You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2021/01/26 08:16:53 UTC
[JENKINS] Lucene » Lucene-Solr-Tests-8.8 - Build # 156 - Still Unstable!
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.8/156/
1 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.search.join.BlockJoinFacetDistribTest
Error Message:
Timeout occurred while waiting response from server at: http://127.0.0.1:42363/solr
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: Timeout occurred while waiting response from server at: http://127.0.0.1:42363/solr
at __randomizedtesting.SeedInfo.seed([193346FFFDF98283]:0)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:692)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:266)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
at org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:369)
at org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:297)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1171)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:934)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:866)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:214)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:231)
at org.apache.solr.search.join.BlockJoinFacetDistribTest.setupCluster(BlockJoinFacetDistribTest.java:71)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:878)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Caused by: java.net.SocketTimeoutException: Read timed out
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
at java.net.SocketInputStream.read(SocketInputStream.java:171)
at java.net.SocketInputStream.read(SocketInputStream.java:141)
at org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137)
at org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153)
at org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:280)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56)
at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259)
at org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163)
at org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:157)
at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273)
at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125)
at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272)
at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186)
at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89)
at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:571)
... 36 more
Build Log:
[...truncated 14261 lines...]
[junit4] Suite: org.apache.solr.search.join.BlockJoinFacetDistribTest
[junit4] 2> 703889 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/server/solr/configsets/_default/conf'
[junit4] 2> 703889 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J1/temp/solr.search.join.BlockJoinFacetDistribTest_193346FFFDF98283-001/data-dir-94-001
[junit4] 2> 703889 WARN (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=20 numCloses=20
[junit4] 2> 703889 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 703891 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 703891 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 703891 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.c.SolrCloudTestCase Using per-replica state
[junit4] 2> 703891 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 6 servers in /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J1/temp/solr.search.join.BlockJoinFacetDistribTest_193346FFFDF98283-001/tempDir-001
[junit4] 2> 703892 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 703892 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 703892 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 703894 WARN (ZkTestServer Run Thread) [ ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 703992 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port: 44643
[junit4] 2> 703992 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:44643
[junit4] 2> 703992 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:44643
[junit4] 2> 703992 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 44643
[junit4] 2> 703996 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 704008 INFO (zkConnectionManagerCallback-6542-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 704008 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 704018 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 704021 INFO (zkConnectionManagerCallback-6544-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 704021 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 704024 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 704025 INFO (zkConnectionManagerCallback-6546-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 704025 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 704128 INFO (jetty-launcher-6547-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 704128 INFO (jetty-launcher-6547-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 704128 INFO (jetty-launcher-6547-thread-4) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 704128 INFO (jetty-launcher-6547-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 704128 INFO (jetty-launcher-6547-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 704128 INFO (jetty-launcher-6547-thread-3) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 704128 INFO (jetty-launcher-6547-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 704128 INFO (jetty-launcher-6547-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 704129 INFO (jetty-launcher-6547-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 704129 INFO (jetty-launcher-6547-thread-5) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 704129 INFO (jetty-launcher-6547-thread-5) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 704129 INFO (jetty-launcher-6547-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 704129 INFO (jetty-launcher-6547-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 704129 INFO (jetty-launcher-6547-thread-5) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 704129 INFO (jetty-launcher-6547-thread-2) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 704129 INFO (jetty-launcher-6547-thread-6) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 704130 INFO (jetty-launcher-6547-thread-6) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 704130 INFO (jetty-launcher-6547-thread-6) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 704132 INFO (jetty-launcher-6547-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 704132 INFO (jetty-launcher-6547-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 704132 INFO (jetty-launcher-6547-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 704133 INFO (jetty-launcher-6547-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@745b933a{/solr,null,AVAILABLE}
[junit4] 2> 704136 INFO (jetty-launcher-6547-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 704136 INFO (jetty-launcher-6547-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 704136 INFO (jetty-launcher-6547-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 704136 INFO (jetty-launcher-6547-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@52ce4810{/solr,null,AVAILABLE}
[junit4] 2> 704137 INFO (jetty-launcher-6547-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 704137 INFO (jetty-launcher-6547-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 704137 INFO (jetty-launcher-6547-thread-3) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 704137 INFO (jetty-launcher-6547-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@52c40194{/solr,null,AVAILABLE}
[junit4] 2> 704144 INFO (jetty-launcher-6547-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@409e1cbb{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42363}
[junit4] 2> 704144 INFO (jetty-launcher-6547-thread-2) [ ] o.e.j.s.Server Started @704175ms
[junit4] 2> 704144 INFO (jetty-launcher-6547-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:44643/solr, hostPort=42363}
[junit4] 2> 704144 INFO (jetty-launcher-6547-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 704144 ERROR (jetty-launcher-6547-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 704144 INFO (jetty-launcher-6547-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 704144 INFO (jetty-launcher-6547-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 704144 INFO (jetty-launcher-6547-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.8.0
[junit4] 2> 704144 INFO (jetty-launcher-6547-thread-4) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 704144 INFO (jetty-launcher-6547-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 704145 INFO (jetty-launcher-6547-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr
[junit4] 2> 704145 INFO (jetty-launcher-6547-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-01-26T07:31:13.025Z
[junit4] 2> 704145 INFO (jetty-launcher-6547-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@50a9268{/solr,null,AVAILABLE}
[junit4] 2> 704145 INFO (jetty-launcher-6547-thread-6) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 704145 INFO (jetty-launcher-6547-thread-6) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 704145 INFO (jetty-launcher-6547-thread-6) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 704146 INFO (jetty-launcher-6547-thread-6) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4b649f6c{/solr,null,AVAILABLE}
[junit4] 2> 704146 INFO (jetty-launcher-6547-thread-5) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 704146 INFO (jetty-launcher-6547-thread-5) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 704147 INFO (jetty-launcher-6547-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@638431b7{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:41523}
[junit4] 2> 704147 INFO (jetty-launcher-6547-thread-3) [ ] o.e.j.s.Server Started @704178ms
[junit4] 2> 704147 INFO (jetty-launcher-6547-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:44643/solr, hostPort=41523}
[junit4] 2> 704147 ERROR (jetty-launcher-6547-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 704147 INFO (jetty-launcher-6547-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 704147 INFO (jetty-launcher-6547-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.8.0
[junit4] 2> 704147 INFO (jetty-launcher-6547-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 704147 INFO (jetty-launcher-6547-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr
[junit4] 2> 704147 INFO (jetty-launcher-6547-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-01-26T07:31:13.027Z
[junit4] 2> 704148 INFO (jetty-launcher-6547-thread-5) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 704148 INFO (jetty-launcher-6547-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 704149 INFO (jetty-launcher-6547-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1e92c25c{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:33663}
[junit4] 2> 704149 INFO (jetty-launcher-6547-thread-1) [ ] o.e.j.s.Server Started @704179ms
[junit4] 2> 704149 INFO (jetty-launcher-6547-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:44643/solr, hostPort=33663}
[junit4] 2> 704149 ERROR (jetty-launcher-6547-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 704149 INFO (jetty-launcher-6547-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 704149 INFO (jetty-launcher-6547-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.8.0
[junit4] 2> 704149 INFO (jetty-launcher-6547-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 704149 INFO (jetty-launcher-6547-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr
[junit4] 2> 704149 INFO (jetty-launcher-6547-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-01-26T07:31:13.029Z
[junit4] 2> 704152 INFO (jetty-launcher-6547-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 704156 INFO (zkConnectionManagerCallback-6551-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 704156 INFO (jetty-launcher-6547-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 704157 INFO (jetty-launcher-6547-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 704157 INFO (jetty-launcher-6547-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 704160 INFO (jetty-launcher-6547-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@28c8fb67{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:35425}
[junit4] 2> 704160 INFO (jetty-launcher-6547-thread-4) [ ] o.e.j.s.Server Started @704191ms
[junit4] 2> 704160 INFO (jetty-launcher-6547-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:44643/solr, hostPort=35425}
[junit4] 2> 704160 INFO (jetty-launcher-6547-thread-6) [ ] o.e.j.s.AbstractConnector Started ServerConnector@14e7aedc{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:37147}
[junit4] 2> 704160 INFO (jetty-launcher-6547-thread-6) [ ] o.e.j.s.Server Started @704191ms
[junit4] 2> 704160 ERROR (jetty-launcher-6547-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 704160 INFO (jetty-launcher-6547-thread-6) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:44643/solr, hostPort=37147}
[junit4] 2> 704160 INFO (jetty-launcher-6547-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 704160 INFO (jetty-launcher-6547-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.8.0
[junit4] 2> 704160 INFO (jetty-launcher-6547-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 704161 INFO (jetty-launcher-6547-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr
[junit4] 2> 704161 INFO (jetty-launcher-6547-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-01-26T07:31:13.041Z
[junit4] 2> 704161 ERROR (jetty-launcher-6547-thread-6) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 704161 INFO (jetty-launcher-6547-thread-6) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 704161 INFO (jetty-launcher-6547-thread-6) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.8.0
[junit4] 2> 704161 INFO (jetty-launcher-6547-thread-6) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 704161 INFO (jetty-launcher-6547-thread-6) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr
[junit4] 2> 704161 INFO (jetty-launcher-6547-thread-6) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-01-26T07:31:13.041Z
[junit4] 2> 704161 INFO (zkConnectionManagerCallback-6549-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 704161 INFO (jetty-launcher-6547-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 704162 INFO (jetty-launcher-6547-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 704162 INFO (jetty-launcher-6547-thread-3) [ ] o.a.s.c.SolrXmlConfig Metrics collection is disabled.
[junit4] 2> 704163 INFO (jetty-launcher-6547-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 704163 INFO (jetty-launcher-6547-thread-5) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5f1242b7{/solr,null,AVAILABLE}
[junit4] 2> 704168 WARN (jetty-launcher-6547-thread-3-SendThread(127.0.0.1:44643)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x102f48577470003.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x102f48577470003, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x102f48577470003, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 704168 INFO (jetty-launcher-6547-thread-2) [ ] o.a.s.c.SolrXmlConfig Metrics collection is disabled.
[junit4] 2> 704168 INFO (zkConnectionManagerCallback-6553-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 704168 INFO (jetty-launcher-6547-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 704169 INFO (zkConnectionManagerCallback-6555-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 704169 INFO (jetty-launcher-6547-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 704173 INFO (jetty-launcher-6547-thread-6) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 704173 INFO (jetty-launcher-6547-thread-5) [ ] o.e.j.s.AbstractConnector Started ServerConnector@67d8a883{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:34529}
[junit4] 2> 704173 INFO (jetty-launcher-6547-thread-5) [ ] o.e.j.s.Server Started @704204ms
[junit4] 2> 704173 INFO (jetty-launcher-6547-thread-5) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:44643/solr, hostPort=34529}
[junit4] 2> 704173 ERROR (jetty-launcher-6547-thread-5) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 704173 INFO (jetty-launcher-6547-thread-5) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 704173 INFO (jetty-launcher-6547-thread-5) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.8.0
[junit4] 2> 704173 INFO (jetty-launcher-6547-thread-5) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 704173 INFO (jetty-launcher-6547-thread-5) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr
[junit4] 2> 704174 INFO (jetty-launcher-6547-thread-5) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-01-26T07:31:13.054Z
[junit4] 2> 704175 INFO (jetty-launcher-6547-thread-5) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 704175 INFO (zkConnectionManagerCallback-6557-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 704175 INFO (jetty-launcher-6547-thread-6) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 704175 INFO (zkConnectionManagerCallback-6559-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 704175 INFO (jetty-launcher-6547-thread-5) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 704274 INFO (jetty-launcher-6547-thread-5) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 704275 INFO (jetty-launcher-6547-thread-6) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 704275 INFO (jetty-launcher-6547-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 704275 INFO (jetty-launcher-6547-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 704279 INFO (jetty-launcher-6547-thread-6) [ ] o.a.s.c.SolrXmlConfig Metrics collection is disabled.
[junit4] 2> 704279 INFO (jetty-launcher-6547-thread-4) [ ] o.a.s.c.SolrXmlConfig Metrics collection is disabled.
[junit4] 2> 704279 INFO (jetty-launcher-6547-thread-1) [ ] o.a.s.c.SolrXmlConfig Metrics collection is disabled.
[junit4] 2> 704281 INFO (jetty-launcher-6547-thread-5) [ ] o.a.s.c.SolrXmlConfig Metrics collection is disabled.
[junit4] 2> 704282 WARN (jetty-launcher-6547-thread-6-SendThread(127.0.0.1:44643)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x102f48577470007.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x102f48577470007, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x102f48577470007, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 704282 WARN (jetty-launcher-6547-thread-4-SendThread(127.0.0.1:44643)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x102f48577470006.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x102f48577470006, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x102f48577470006, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 704283 WARN (jetty-launcher-6547-thread-5-SendThread(127.0.0.1:44643)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x102f48577470008.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x102f48577470008, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x102f48577470008, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 704489 WARN (jetty-launcher-6547-thread-1-SendThread(127.0.0.1:44643)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x102f48577470005.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x102f48577470005, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x102f48577470005, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 705151 INFO (jetty-launcher-6547-thread-4) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 705152 WARN (jetty-launcher-6547-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7a147ad9[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 705152 WARN (jetty-launcher-6547-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7a147ad9[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 705160 WARN (jetty-launcher-6547-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@108777c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 705160 WARN (jetty-launcher-6547-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@108777c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 705161 INFO (jetty-launcher-6547-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44643/solr
[junit4] 2> 705185 INFO (jetty-launcher-6547-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 705203 INFO (zkConnectionManagerCallback-6585-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 705203 INFO (jetty-launcher-6547-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 705206 WARN (jetty-launcher-6547-thread-4-SendThread(127.0.0.1:44643)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x102f48577470009.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x102f48577470009, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x102f48577470009, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 705380 INFO (jetty-launcher-6547-thread-4) [n:127.0.0.1:35425_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 705384 INFO (jetty-launcher-6547-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 705400 WARN (jetty-launcher-6547-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@68845b5c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 705412 INFO (zkConnectionManagerCallback-6587-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 705412 INFO (jetty-launcher-6547-thread-4) [n:127.0.0.1:35425_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 705414 WARN (jetty-launcher-6547-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@68845b5c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 705432 INFO (jetty-launcher-6547-thread-5) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 705434 WARN (jetty-launcher-6547-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2a2a316d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 705434 WARN (jetty-launcher-6547-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2a2a316d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 705435 INFO (jetty-launcher-6547-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44643/solr
[junit4] 2> 705450 INFO (jetty-launcher-6547-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 705457 WARN (jetty-launcher-6547-thread-5) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2d3fdb60[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 705457 WARN (jetty-launcher-6547-thread-5) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2d3fdb60[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 705465 INFO (zkConnectionManagerCallback-6600-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 705465 INFO (jetty-launcher-6547-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 705491 WARN (jetty-launcher-6547-thread-2-SendThread(127.0.0.1:44643)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x102f4857747000b.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x102f4857747000b, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x102f4857747000b, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 705611 WARN (jetty-launcher-6547-thread-5) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@62d825c6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 705611 WARN (jetty-launcher-6547-thread-5) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@62d825c6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 705612 INFO (jetty-launcher-6547-thread-5) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44643/solr
[junit4] 2> 705634 INFO (jetty-launcher-6547-thread-5) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 705642 INFO (zkConnectionManagerCallback-6605-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 705642 INFO (jetty-launcher-6547-thread-5) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 705646 WARN (jetty-launcher-6547-thread-5-SendThread(127.0.0.1:44643)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x102f4857747000c.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x102f4857747000c, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x102f4857747000c, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 705681 INFO (jetty-launcher-6547-thread-4) [n:127.0.0.1:35425_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:35425_solr
[junit4] 2> 705682 INFO (jetty-launcher-6547-thread-4) [n:127.0.0.1:35425_solr ] o.a.s.c.Overseer Overseer (id=72889398060318730-127.0.0.1:35425_solr-n_0000000000) starting
[junit4] 2> 705686 INFO (jetty-launcher-6547-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 705687 WARN (jetty-launcher-6547-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@58cb26fb[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 705687 WARN (jetty-launcher-6547-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@58cb26fb[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 705691 WARN (jetty-launcher-6547-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@60db604[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 705691 WARN (jetty-launcher-6547-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@60db604[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 705691 INFO (jetty-launcher-6547-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44643/solr
[junit4] 2> 705714 INFO (jetty-launcher-6547-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 705716 INFO (jetty-launcher-6547-thread-2) [n:127.0.0.1:42363_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 705717 INFO (OverseerStateUpdate-72889398060318730-127.0.0.1:35425_solr-n_0000000000) [n:127.0.0.1:35425_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:35425_solr
[junit4] 2> 705717 INFO (zkConnectionManagerCallback-6613-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 705717 INFO (jetty-launcher-6547-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 705718 INFO (jetty-launcher-6547-thread-4) [n:127.0.0.1:35425_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:35425_solr
[junit4] 2> 705719 INFO (zkConnectionManagerCallback-6615-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 705719 INFO (jetty-launcher-6547-thread-2) [n:127.0.0.1:42363_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 705719 WARN (jetty-launcher-6547-thread-1-SendThread(127.0.0.1:44643)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x102f4857747000d.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x102f4857747000d, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x102f4857747000d, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 705721 INFO (OverseerStateUpdate-72889398060318730-127.0.0.1:35425_solr-n_0000000000) [n:127.0.0.1:35425_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 705725 INFO (jetty-launcher-6547-thread-4) [n:127.0.0.1:35425_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 705726 WARN (jetty-launcher-6547-thread-4) [n:127.0.0.1:35425_solr ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 705742 INFO (jetty-launcher-6547-thread-2) [n:127.0.0.1:42363_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 705747 INFO (jetty-launcher-6547-thread-4) [n:127.0.0.1:35425_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J1/temp/solr.search.join.BlockJoinFacetDistribTest_193346FFFDF98283-001/tempDir-001/node3
[junit4] 2> 705752 INFO (jetty-launcher-6547-thread-2) [n:127.0.0.1:42363_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:42363_solr as DOWN
[junit4] 2> 705759 INFO (jetty-launcher-6547-thread-2) [n:127.0.0.1:42363_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 705759 INFO (jetty-launcher-6547-thread-2) [n:127.0.0.1:42363_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:42363_solr
[junit4] 2> 705761 INFO (zkCallback-6586-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 705766 INFO (jetty-launcher-6547-thread-2) [n:127.0.0.1:42363_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 705767 WARN (jetty-launcher-6547-thread-2) [n:127.0.0.1:42363_solr ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 705778 INFO (jetty-launcher-6547-thread-2) [n:127.0.0.1:42363_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J1/temp/solr.search.join.BlockJoinFacetDistribTest_193346FFFDF98283-001/tempDir-001/node1
[junit4] 2> 705778 INFO (zkCallback-6614-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 705816 INFO (jetty-launcher-6547-thread-5) [n:127.0.0.1:34529_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 705817 INFO (zkConnectionManagerCallback-6631-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 705817 INFO (jetty-launcher-6547-thread-5) [n:127.0.0.1:34529_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 705821 INFO (jetty-launcher-6547-thread-5) [n:127.0.0.1:34529_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 705824 INFO (jetty-launcher-6547-thread-5) [n:127.0.0.1:34529_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:34529_solr as DOWN
[junit4] 2> 705825 INFO (jetty-launcher-6547-thread-5) [n:127.0.0.1:34529_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 705825 INFO (jetty-launcher-6547-thread-5) [n:127.0.0.1:34529_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34529_solr
[junit4] 2> 705826 INFO (zkCallback-6586-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 705826 INFO (zkCallback-6614-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 705827 INFO (jetty-launcher-6547-thread-5) [n:127.0.0.1:34529_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 705828 WARN (jetty-launcher-6547-thread-5) [n:127.0.0.1:34529_solr ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 705838 INFO (zkCallback-6630-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 705839 INFO (jetty-launcher-6547-thread-5) [n:127.0.0.1:34529_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J1/temp/solr.search.join.BlockJoinFacetDistribTest_193346FFFDF98283-001/tempDir-001/node5
[junit4] 2> 705984 INFO (jetty-launcher-6547-thread-1) [n:127.0.0.1:33663_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 705985 INFO (zkConnectionManagerCallback-6639-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 705985 INFO (jetty-launcher-6547-thread-1) [n:127.0.0.1:33663_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 705989 INFO (jetty-launcher-6547-thread-1) [n:127.0.0.1:33663_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 705991 INFO (jetty-launcher-6547-thread-1) [n:127.0.0.1:33663_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:33663_solr as DOWN
[junit4] 2> 705992 INFO (jetty-launcher-6547-thread-1) [n:127.0.0.1:33663_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 705992 INFO (jetty-launcher-6547-thread-1) [n:127.0.0.1:33663_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33663_solr
[junit4] 2> 705993 INFO (zkCallback-6586-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 705993 INFO (zkCallback-6630-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 705993 INFO (zkCallback-6614-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 705994 INFO (jetty-launcher-6547-thread-1) [n:127.0.0.1:33663_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 705995 WARN (jetty-launcher-6547-thread-1) [n:127.0.0.1:33663_solr ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 706005 INFO (jetty-launcher-6547-thread-1) [n:127.0.0.1:33663_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J1/temp/solr.search.join.BlockJoinFacetDistribTest_193346FFFDF98283-001/tempDir-001/node4
[junit4] 2> 706008 INFO (zkCallback-6638-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 706270 INFO (jetty-launcher-6547-thread-6) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 706271 WARN (jetty-launcher-6547-thread-6) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@71708461[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 706271 WARN (jetty-launcher-6547-thread-6) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@71708461[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 706276 WARN (jetty-launcher-6547-thread-6) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4943114b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 706276 WARN (jetty-launcher-6547-thread-6) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4943114b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 706277 INFO (jetty-launcher-6547-thread-6) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44643/solr
[junit4] 2> 706278 INFO (jetty-launcher-6547-thread-6) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 706280 INFO (zkConnectionManagerCallback-6653-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 706281 INFO (jetty-launcher-6547-thread-6) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 706282 WARN (jetty-launcher-6547-thread-6-SendThread(127.0.0.1:44643)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x102f48577470011.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x102f48577470011, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x102f48577470011, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 706531 INFO (jetty-launcher-6547-thread-6) [n:127.0.0.1:37147_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 706535 INFO (jetty-launcher-6547-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 706535 INFO (zkConnectionManagerCallback-6655-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 706535 INFO (jetty-launcher-6547-thread-6) [n:127.0.0.1:37147_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 706536 WARN (jetty-launcher-6547-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4d84f2cf[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 706537 WARN (jetty-launcher-6547-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4d84f2cf[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 706541 INFO (jetty-launcher-6547-thread-6) [n:127.0.0.1:37147_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 706543 WARN (jetty-launcher-6547-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@75cb98d0[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 706543 WARN (jetty-launcher-6547-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@75cb98d0[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 706545 INFO (jetty-launcher-6547-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44643/solr
[junit4] 2> 706546 INFO (jetty-launcher-6547-thread-6) [n:127.0.0.1:37147_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:37147_solr as DOWN
[junit4] 2> 706547 INFO (jetty-launcher-6547-thread-6) [n:127.0.0.1:37147_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 706547 INFO (jetty-launcher-6547-thread-6) [n:127.0.0.1:37147_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:37147_solr
[junit4] 2> 706547 INFO (jetty-launcher-6547-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 706550 INFO (zkCallback-6586-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 706550 INFO (zkCallback-6630-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 706551 INFO (zkCallback-6614-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 706551 INFO (zkCallback-6638-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 706551 INFO (zkConnectionManagerCallback-6665-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 706551 INFO (jetty-launcher-6547-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 706551 INFO (zkCallback-6654-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 706552 INFO (jetty-launcher-6547-thread-6) [n:127.0.0.1:37147_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 706552 WARN (jetty-launcher-6547-thread-6) [n:127.0.0.1:37147_solr ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 706564 WARN (jetty-launcher-6547-thread-3-SendThread(127.0.0.1:44643)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x102f48577470013.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x102f48577470013, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x102f48577470013, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 706571 INFO (jetty-launcher-6547-thread-6) [n:127.0.0.1:37147_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J1/temp/solr.search.join.BlockJoinFacetDistribTest_193346FFFDF98283-001/tempDir-001/node6
[junit4] 2> 706679 INFO (jetty-launcher-6547-thread-3) [n:127.0.0.1:41523_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 706681 INFO (zkConnectionManagerCallback-6671-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 706681 INFO (jetty-launcher-6547-thread-3) [n:127.0.0.1:41523_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 706691 INFO (jetty-launcher-6547-thread-3) [n:127.0.0.1:41523_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
[junit4] 2> 706694 INFO (jetty-launcher-6547-thread-3) [n:127.0.0.1:41523_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:41523_solr as DOWN
[junit4] 2> 706695 INFO (jetty-launcher-6547-thread-3) [n:127.0.0.1:41523_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 706695 INFO (jetty-launcher-6547-thread-3) [n:127.0.0.1:41523_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41523_solr
[junit4] 2> 706697 INFO (zkCallback-6614-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 706697 INFO (zkCallback-6654-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 706697 INFO (zkCallback-6670-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 706699 INFO (zkCallback-6630-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 706699 INFO (zkCallback-6586-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 706699 INFO (zkCallback-6638-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 706703 INFO (jetty-launcher-6547-thread-3) [n:127.0.0.1:41523_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 706704 WARN (jetty-launcher-6547-thread-3) [n:127.0.0.1:41523_solr ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 706722 INFO (jetty-launcher-6547-thread-3) [n:127.0.0.1:41523_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J1/temp/solr.search.join.BlockJoinFacetDistribTest_193346FFFDF98283-001/tempDir-001/node2
[junit4] 2> 706740 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=6
[junit4] 2> 706744 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 706748 INFO (zkConnectionManagerCallback-6682-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 706748 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 706752 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (6)
[junit4] 2> 706755 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44643/solr ready
[junit4] 2> 707953 INFO (OverseerThreadFactory-6620-thread-1-processing-n:127.0.0.1:35425_solr) [n:127.0.0.1:35425_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection facetcollection
[junit4] 2> 708070 INFO (OverseerThreadFactory-6620-thread-1-processing-n:127.0.0.1:35425_solr) [n:127.0.0.1:35425_solr ] o.a.s.c.c.ZkStateReader per-replica-state ver: 2 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708090 INFO (OverseerStateUpdate-72889398060318730-127.0.0.1:35425_solr-n_0000000000) [n:127.0.0.1:35425_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"facetcollection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"facetcollection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:35425_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 708115 INFO (OverseerThreadFactory-6620-thread-1-processing-n:127.0.0.1:35425_solr) [n:127.0.0.1:35425_solr ] o.a.s.c.c.ZkStateReader per-replica-state ver: 3 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708119 INFO (OverseerStateUpdate-72889398060318730-127.0.0.1:35425_solr-n_0000000000) [n:127.0.0.1:35425_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"facetcollection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"facetcollection_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:33663_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 708140 INFO (OverseerThreadFactory-6620-thread-1-processing-n:127.0.0.1:35425_solr) [n:127.0.0.1:35425_solr ] o.a.s.c.c.ZkStateReader per-replica-state ver: 4 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708141 INFO (OverseerStateUpdate-72889398060318730-127.0.0.1:35425_solr-n_0000000000) [n:127.0.0.1:35425_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"facetcollection",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"facetcollection_shard2_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:41523_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 708148 INFO (OverseerThreadFactory-6620-thread-1-processing-n:127.0.0.1:35425_solr) [n:127.0.0.1:35425_solr ] o.a.s.c.c.ZkStateReader per-replica-state ver: 5 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708151 INFO (OverseerStateUpdate-72889398060318730-127.0.0.1:35425_solr-n_0000000000) [n:127.0.0.1:35425_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"facetcollection",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"facetcollection_shard2_replica_n6",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:37147_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 708161 INFO (OverseerThreadFactory-6620-thread-1-processing-n:127.0.0.1:35425_solr) [n:127.0.0.1:35425_solr ] o.a.s.c.c.ZkStateReader per-replica-state ver: 6 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708168 INFO (OverseerStateUpdate-72889398060318730-127.0.0.1:35425_solr-n_0000000000) [n:127.0.0.1:35425_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"facetcollection",
[junit4] 2> "shard":"shard3",
[junit4] 2> "core":"facetcollection_shard3_replica_n8",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:34529_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 708170 INFO (OverseerThreadFactory-6620-thread-1-processing-n:127.0.0.1:35425_solr) [n:127.0.0.1:35425_solr ] o.a.s.c.c.ZkStateReader per-replica-state ver: 6 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708173 INFO (OverseerStateUpdate-72889398060318730-127.0.0.1:35425_solr-n_0000000000) [n:127.0.0.1:35425_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"facetcollection",
[junit4] 2> "shard":"shard3",
[junit4] 2> "core":"facetcollection_shard3_replica_n10",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:42363_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 708326 INFO (OverseerThreadFactory-6620-thread-1-processing-n:127.0.0.1:35425_solr) [n:127.0.0.1:35425_solr ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708339 INFO (qtp638521814-9845) [n:127.0.0.1:35425_solr x:facetcollection_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=solrCloudCollectionConfig&newCollection=true&collection=facetcollection&version=2&replicaType=NRT&property.config=solrconfig-blockjoinfacetcomponent.xml&property.schema=schema-blockjoinfacetcomponent.xml&coreNodeName=core_node3&name=facetcollection_shard1_replica_n1&action=CREATE&numShards=3&shard=shard1&wt=javabin
[junit4] 2> 708339 INFO (qtp438326248-9853) [n:127.0.0.1:37147_solr x:facetcollection_shard2_replica_n6 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=solrCloudCollectionConfig&newCollection=true&collection=facetcollection&version=2&replicaType=NRT&property.config=solrconfig-blockjoinfacetcomponent.xml&property.schema=schema-blockjoinfacetcomponent.xml&coreNodeName=core_node9&name=facetcollection_shard2_replica_n6&action=CREATE&numShards=3&shard=shard2&wt=javabin
[junit4] 2> 708339 INFO (qtp638521814-9845) [n:127.0.0.1:35425_solr x:facetcollection_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 708340 INFO (qtp274021926-9821) [n:127.0.0.1:33663_solr x:facetcollection_shard1_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=solrCloudCollectionConfig&newCollection=true&collection=facetcollection&version=2&replicaType=NRT&property.config=solrconfig-blockjoinfacetcomponent.xml&property.schema=schema-blockjoinfacetcomponent.xml&coreNodeName=core_node5&name=facetcollection_shard1_replica_n2&action=CREATE&numShards=3&shard=shard1&wt=javabin
[junit4] 2> 708341 INFO (qtp1833161327-9831) [n:127.0.0.1:41523_solr x:facetcollection_shard2_replica_n4 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=solrCloudCollectionConfig&newCollection=true&collection=facetcollection&version=2&replicaType=NRT&property.config=solrconfig-blockjoinfacetcomponent.xml&property.schema=schema-blockjoinfacetcomponent.xml&coreNodeName=core_node7&name=facetcollection_shard2_replica_n4&action=CREATE&numShards=3&shard=shard2&wt=javabin
[junit4] 2> 708342 INFO (qtp1763662800-9840) [n:127.0.0.1:34529_solr x:facetcollection_shard3_replica_n8 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=solrCloudCollectionConfig&newCollection=true&collection=facetcollection&version=2&replicaType=NRT&property.config=solrconfig-blockjoinfacetcomponent.xml&property.schema=schema-blockjoinfacetcomponent.xml&coreNodeName=core_node11&name=facetcollection_shard3_replica_n8&action=CREATE&numShards=3&shard=shard3&wt=javabin
[junit4] 2> 708342 INFO (qtp1314515712-9814) [n:127.0.0.1:42363_solr x:facetcollection_shard3_replica_n10 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=solrCloudCollectionConfig&newCollection=true&collection=facetcollection&version=2&replicaType=NRT&property.config=solrconfig-blockjoinfacetcomponent.xml&property.schema=schema-blockjoinfacetcomponent.xml&coreNodeName=core_node12&name=facetcollection_shard3_replica_n10&action=CREATE&numShards=3&shard=shard3&wt=javabin
[junit4] 2> 708344 INFO (qtp274021926-9821) [n:127.0.0.1:33663_solr x:facetcollection_shard1_replica_n2 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708344 INFO (qtp638521814-9845) [n:127.0.0.1:35425_solr c:facetcollection s:shard1 r:core_node3 x:facetcollection_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 708344 INFO (qtp274021926-9821) [n:127.0.0.1:33663_solr c:facetcollection s:shard1 r:core_node5 x:facetcollection_shard1_replica_n2 ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 708344 INFO (qtp1314515712-9814) [n:127.0.0.1:42363_solr x:facetcollection_shard3_replica_n10 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708345 INFO (qtp1314515712-9814) [n:127.0.0.1:42363_solr c:facetcollection s:shard3 r:core_node12 x:facetcollection_shard3_replica_n10 ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 708346 INFO (qtp438326248-9853) [n:127.0.0.1:37147_solr x:facetcollection_shard2_replica_n6 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708347 INFO (qtp438326248-9853) [n:127.0.0.1:37147_solr c:facetcollection s:shard2 r:core_node9 x:facetcollection_shard2_replica_n6 ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 708347 INFO (qtp1833161327-9831) [n:127.0.0.1:41523_solr x:facetcollection_shard2_replica_n4 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708347 INFO (qtp1833161327-9831) [n:127.0.0.1:41523_solr c:facetcollection s:shard2 r:core_node7 x:facetcollection_shard2_replica_n4 ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 708347 INFO (qtp1763662800-9840) [n:127.0.0.1:34529_solr x:facetcollection_shard3_replica_n8 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708348 INFO (qtp1763662800-9840) [n:127.0.0.1:34529_solr c:facetcollection s:shard3 r:core_node11 x:facetcollection_shard3_replica_n8 ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 708349 INFO (qtp638521814-9845) [n:127.0.0.1:35425_solr c:facetcollection s:shard1 r:core_node3 x:facetcollection_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708349 INFO (qtp274021926-9821) [n:127.0.0.1:33663_solr c:facetcollection s:shard1 r:core_node5 x:facetcollection_shard1_replica_n2 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708350 INFO (qtp1314515712-9814) [n:127.0.0.1:42363_solr c:facetcollection s:shard3 r:core_node12 x:facetcollection_shard3_replica_n10 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708350 INFO (qtp1763662800-9840) [n:127.0.0.1:34529_solr c:facetcollection s:shard3 r:core_node11 x:facetcollection_shard3_replica_n8 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708350 INFO (qtp438326248-9853) [n:127.0.0.1:37147_solr c:facetcollection s:shard2 r:core_node9 x:facetcollection_shard2_replica_n6 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708352 INFO (qtp274021926-9821) [n:127.0.0.1:33663_solr c:facetcollection s:shard1 r:core_node5 x:facetcollection_shard1_replica_n2 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708352 INFO (qtp1833161327-9831) [n:127.0.0.1:41523_solr c:facetcollection s:shard2 r:core_node7 x:facetcollection_shard2_replica_n4 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708352 INFO (qtp638521814-9845) [n:127.0.0.1:35425_solr c:facetcollection s:shard1 r:core_node3 x:facetcollection_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708353 INFO (qtp438326248-9853) [n:127.0.0.1:37147_solr c:facetcollection s:shard2 r:core_node9 x:facetcollection_shard2_replica_n6 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708353 INFO (qtp274021926-9821) [n:127.0.0.1:33663_solr c:facetcollection s:shard1 r:core_node5 x:facetcollection_shard1_replica_n2 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708353 INFO (qtp1314515712-9814) [n:127.0.0.1:42363_solr c:facetcollection s:shard3 r:core_node12 x:facetcollection_shard3_replica_n10 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708354 INFO (qtp638521814-9845) [n:127.0.0.1:35425_solr c:facetcollection s:shard1 r:core_node3 x:facetcollection_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708355 INFO (qtp438326248-9853) [n:127.0.0.1:37147_solr c:facetcollection s:shard2 r:core_node9 x:facetcollection_shard2_replica_n6 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708355 INFO (qtp1763662800-9840) [n:127.0.0.1:34529_solr c:facetcollection s:shard3 r:core_node11 x:facetcollection_shard3_replica_n8 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708356 INFO (qtp1314515712-9814) [n:127.0.0.1:42363_solr c:facetcollection s:shard3 r:core_node12 x:facetcollection_shard3_replica_n10 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708356 INFO (qtp1833161327-9831) [n:127.0.0.1:41523_solr c:facetcollection s:shard2 r:core_node7 x:facetcollection_shard2_replica_n4 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708357 INFO (qtp1763662800-9840) [n:127.0.0.1:34529_solr c:facetcollection s:shard3 r:core_node11 x:facetcollection_shard3_replica_n8 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708359 INFO (qtp1833161327-9831) [n:127.0.0.1:41523_solr c:facetcollection s:shard2 r:core_node7 x:facetcollection_shard2_replica_n4 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 8 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708372 INFO (qtp1763662800-9840) [n:127.0.0.1:34529_solr c:facetcollection s:shard3 r:core_node11 x:facetcollection_shard3_replica_n8 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 10 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708373 INFO (qtp1833161327-9831) [n:127.0.0.1:41523_solr c:facetcollection s:shard2 r:core_node7 x:facetcollection_shard2_replica_n4 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 10 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708385 INFO (qtp1833161327-9831) [n:127.0.0.1:41523_solr c:facetcollection s:shard2 r:core_node7 x:facetcollection_shard2_replica_n4 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 12 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708389 INFO (qtp438326248-9853) [n:127.0.0.1:37147_solr c:facetcollection s:shard2 r:core_node9 x:facetcollection_shard2_replica_n6 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.8.0
[junit4] 2> 708393 INFO (qtp638521814-9845) [n:127.0.0.1:35425_solr c:facetcollection s:shard1 r:core_node3 x:facetcollection_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.8.0
[junit4] 2> 708397 INFO (qtp274021926-9821) [n:127.0.0.1:33663_solr c:facetcollection s:shard1 r:core_node5 x:facetcollection_shard1_replica_n2 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.8.0
[junit4] 2> 708398 INFO (qtp1833161327-9831) [n:127.0.0.1:41523_solr c:facetcollection s:shard2 r:core_node7 x:facetcollection_shard2_replica_n4 ] o.a.s.c.c.ZkStateReader per-replica-state ver: 14 fetched for initializing /collections/facetcollection/state.json
[junit4] 2> 708417 INFO (qtp1314515712-9814) [n:127.0.0.1:42363_solr c:facetcollection s:shard3 r:core_node12 x:facetcollection_shard3_replica_n10 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.8.0
[junit4] 2> 708435 INFO (qtp1763662800-9840) [n:127.0.0.1:34529_solr c:facetcollection s:shard3 r:core_node11 x:facetcollection_shard3_replica_n8 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.8.0
[junit4] 2> 708443 INFO (qtp438326248-9853) [n:127.0.0.1:37147_solr c:facetcollection s:shard2 r:core_node9 x:facetcollection_shard2_replica_n6 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 708443 INFO (qtp438326248-9853) [n:127.0.0.1:37147_solr c:facetcollection s:shard2 r:core_node9 x:facetcollection_shard2_replica_n6 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 708443 INFO (qtp438326248-9853) [n:127.0.0.1:37147_solr c:facetcollection s:shard2 r:core_node9 x:facetcollection_shard2_replica_n6 ] o.a.s.c.CoreContainer Creating SolrCore 'facetcollection_shard2_replica_n6' using configuration from configset solrCloudCollectionConfig, trusted=true
[junit4] 2> 708444 INFO (qtp438326248-9853) [n:127.0.0.1:37147_solr c:facetcollection s:shard2 r:core_node9 x:facetcollection_shard2_replica_n6 ] o.a.s.c.SolrCore [[facetcollection_shard2_replica_n6] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J1/temp/solr.search.join.BlockJoinFacetDistribTest_193346FFFDF98283-001/tempDir-001/node6/facetcollection_shard2_replica_n6], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J1/temp/solr.search.join.BlockJoinFacetDistribTest_193346FFFDF98283-001/tempDir-001/node6/facetcollection_shard2_replica_n6/data/]
[junit4] 2> 708463 INFO (qtp638521814-9845) [n:127.0.0.1:35425_solr c:facetcollection s:shard1 r:core_node3 x:facetcollection_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 708463 INFO (qtp638521814-9845) [n:127.0.0.1:35425_solr c:facetcollection s:shard1 r:core_node3 x:facetcollection_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 708463 INFO (qtp638521814-9845) [n:127.0.0.1:35425_solr c:facetcollection s:shard1 r:core_node3 x:facetcollection_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'facetcollection_shard1_replica_n1' using configuration from configset solrCloudCollectionConfig, trusted=true
[junit4] 2> 708464 INFO (qtp1314515712-9814) [n:127.0.0.1:42363_solr c:facetcollection s:shard3 r:core_node12 x:facetcollection_shard3_replica_n10 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 708465 INFO (qtp1314515712-9814) [n:127.0.0.1:42363_solr c:facetcollection s:shard3 r:core_node12 x:facetcollection_shard3_replica_n10 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 708465 INFO (qtp1314515712-9814) [n:127.0.0.1:42363_solr c:facetcollection s:shard3 r:core_node12 x:facetcollection_shard3_replica_n10 ] o.a.s.c.CoreContainer Creating SolrCore 'facetcollection_shard3_replica_n10' using configuration from configset solrCloudCollectionConfig, trusted=true
[junit4] 2> 708465 INFO (qtp1314515712-9814) [n:127.0.0.1:42363_solr c:facetcollection s:shard3 r:core_node12 x:facetcollection_shard3_replica_n10 ] o.a.s.c.SolrCore [[facetcollection_shard3_replica_n10] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J1/temp/solr.search.join.BlockJoinFacetDistribTest_193346FFFDF98283-001/tempDir-001/node1/facetcollection_shard3_replica_n10], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J1/temp/solr.search.join.BlockJoinFacetDistribTest_193346FFFDF98283-001/tempDir-001/node1/facetcollection_shard3_replica_n10/data/]
[junit4] 2> 708468 INFO (qtp638521814-9845) [n:127.0.0.1:35425_solr c:facetcollection s:shard1 r:core_node3 x:facetcollection_shard1_replica_n1 ] o.a.s.c.SolrCore [[facetcollection_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J1/temp/solr.search.join.BlockJoinFacetDistribTest_193346FFFDF98283-001/tempDir-001/node3/facetcollection_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J1/temp/solr.search.join.BlockJoinFacetDistribTest_193346FFFDF98283-001/tempDir-001/node3/facetcollection_shard1_replica_n1/data/]
[junit4] 2> 708469 INFO (qtp274021926-9821) [n:127.0.0.1:33663_solr c:facetcollection s:shard1 r:core_node5 x:facetcollection_shard1_replica_n2 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 708469 INFO (qtp1833161327-9831) [n:127.0.0.1:41523_solr c:facetcollection s:shard2 r:core_node7 x:facetcollection_shard2_replica_n4 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.8.0
[junit4] 2> 708469 INFO (qtp274021926-9821) [n:127.0.0.1:33663_solr c:facetcollection s:shard1 r:core_node5 x:facetcollection_shard1_replica_n2 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 708469 INFO (qtp274021926-9821) [n:127.0.0.1:33663_solr c:facetcollection s:shard1 r:core_node5 x:facetcollection_shard1_replica_n2 ] o.a.s.c.CoreContainer Creating SolrCore 'facetcollection_shard1_replica_n2' using configuration from configset solrCloudCollectionConfig, trusted=true
[junit4] 2> 708470 INFO (qtp274021926-9821) [n:127.0.0.1:33663_solr c:facetcollection s:shard1 r:core_node5 x:facetcollection_shard1_replica_n2 ] o.a.s.c.SolrCore [[facetcollection_shard1_replica_n2] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J1/temp/solr.search.join.BlockJoinFacetDistribTest_193346FFFDF98283-001/tempDir-001/node4/facetcollection_shard1_replica_n2], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J1/temp/solr.search.join.BlockJoinFacetDistribTest_193346FFFDF98283-001/tempDir-001/node4/facetcollection_shard1_replica_n2/data/]
[junit4] 2> 708510 INFO (qtp1833161327-9831) [n:127.0.0.1:41523_solr c:facetcollection s:shard2 r:core_node7 x:facetcollection_shard2_replica_n4 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 708510 INFO (qtp1833161327-9831) [n:127.0.0.1:41523_solr c:facetcollection s:shard2 r:core_node7 x:facetcollection_shard2_replica_n4 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 708510 INFO (qtp1833161327-9831) [n:127.0.0.1:41523_solr c:facetcollection s:shard2 r:core_node7 x:facetcollection_shard2_replica_n4 ] o.a.s.c.CoreContainer Creating SolrCore 'facetcollection_shard2_replica_n4' using configuration from configset solrCloudCollectionConfig, trusted=true
[junit4] 2> 708511 INFO (qtp1833161327-9831) [n:127.0.0.1:41523_solr
[...truncated too long message...]
alingTriggerThread-72889398060318730-127.0.0.1:35425_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 798691 INFO (jetty-closer-6713-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72889398060318730-127.0.0.1:35425_solr-n_0000000000) closing
[junit4] 2> 798691 INFO (closeThreadPool-6737-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72889398060318730-127.0.0.1:35425_solr-n_0000000000) closing
[junit4] 2> 798692 INFO (jetty-closer-6713-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@28c8fb67{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 798692 INFO (jetty-closer-6713-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@50a9268{/solr,null,STOPPED}
[junit4] 2> 798692 INFO (jetty-closer-6713-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 798693 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 798896 WARN (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 7 /solr/aliases.json
[junit4] 2> 7 /solr/clusterprops.json
[junit4] 2> 6 /solr/collections/facetcollection/terms/shard2
[junit4] 2> 6 /solr/collections/facetcollection/terms/shard1
[junit4] 2> 6 /solr/packages.json
[junit4] 2> 6 /solr/security.json
[junit4] 2> 6 /solr/configs/solrCloudCollectionConfig
[junit4] 2> 5 /solr/collections/facetcollection/terms/shard3
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 23 /solr/collections/facetcollection/state.json
[junit4] 2> 7 /solr/clusterstate.json
[junit4] 2> 2 /solr/autoscaling.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 49 /solr/collections/facetcollection/state.json
[junit4] 2> 34 /solr/live_nodes
[junit4] 2> 30 /solr/overseer/queue
[junit4] 2> 14 /solr/collections
[junit4] 2> 5 /solr/overseer/collection-queue-work
[junit4] 2> 2 /solr/autoscaling/events/.scheduled_maintenance
[junit4] 2> 2 /solr/autoscaling/events/.auto_add_replicas
[junit4] 2> 2 /solr/overseer/queue-work
[junit4] 2>
[junit4] 2> 798903 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:44643
[junit4] 2> 798903 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:44643
[junit4] 2> 798903 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 44643
[junit4] 2> 798903 INFO (SUITE-BlockJoinFacetDistribTest-seed#[193346FFFDF98283]-worker) [ ] o.a.s.SolrTestCaseJ4 ------------------------------------------------------- Done waiting for tracked resources to be released
[junit4] 2> Jan 26, 2021 7:32:47 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=FastCompressingStoredFieldsData(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST, chunkSize=42, maxDocsPerChunk=8, blockShift=8), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST, chunkSize=42, blockSize=8)), sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=it-CH, timezone=Etc/GMT+7
[junit4] 2> NOTE: Linux 4.15.0-112-generic amd64/Oracle Corporation 1.8.0_252 (64-bit)/cpus=4,threads=1,free=341853024,total=496500736
[junit4] 2> NOTE: All tests run in this JVM: [HdfsBasicDistributedZkTest, TestAuthorizationFramework, TestRandomCollapseQParserPlugin, DocValuesNotIndexedTest, OverseerCollectionConfigSetProcessorTest, PluginInfoTest, TestDynamicLoading, SimplePostToolTest, ReindexCollectionTest, SolrCmdDistributorTest, TestCloudDeleteByQuery, TestInitQParser, TestFastLRUCache, ResponseBuilderTest, VMParamsZkACLAndCredentialsProvidersTest, TestCoreContainer, TestReversedWildcardFilterFactory, AssignBackwardCompatibilityTest, TestConfigOverlay, TestManagedResourceStorage, TestExpandComponent, TestNoOpRegenerator, TestStressUserVersions, SimpleFacetsTest, TestPointFields, ScheduledMaintenanceTriggerTest, TestWriterPerf, TestLegacyNumericUtils, TestExportTool, PeerSyncWithLeaderAndIndexFingerprintCachingTest, TestAtomicUpdateErrorCases, ClusterStateTest, RoutingToNodesWithPropertiesTest, TestSolrCloudWithKerberosAlt, LukeRequestHandlerTest, MergeStrategyTest, TestTolerantUpdateProcessorRandomCloud, WordBreakSolrSpellCheckerTest, TestPseudoReturnFields, SortSpecParsingTest, PreAnalyzedUpdateProcessorTest, ZkStateWriterTest, DirectSolrSpellCheckerTest, UUIDFieldTest, CreateRoutedAliasTest, TestSimUtils, TestSimNodeLostTrigger, AggValueSourceTest, TestManagedSchema, ZkNodePropsTest, HttpPartitionOnCommitTest, TestCloudJSONFacetSKG, TestCSVLoader, HighlighterWithoutStoredIdTest, PreAnalyzedFieldTest, TestTrieFacet, HttpTriggerListenerTest, TestGeoJSONResponseWriter, DirectoryFactoriesTest, TestSubQueryTransformer, SpellCheckCollatorWithCollapseTest, TestSolrQueryResponse, TestReqParamsAPI, TestCloudSchemaless, DistribDocExpirationUpdateProcessorTest, DocumentAnalysisRequestHandlerTest, AuditLoggerIntegrationTest, TestRTimerTree, NestedShardedAtomicUpdateTest, BlockJoinFacetDistribTest]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=BlockJoinFacetDistribTest -Dtests.seed=193346FFFDF98283 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=it-CH -Dtests.timezone=Etc/GMT+7 -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J1 | BlockJoinFacetDistribTest (suite) <<<
[junit4] > Throwable #1: org.apache.solr.client.solrj.SolrServerException: Timeout occurred while waiting response from server at: http://127.0.0.1:42363/solr
[junit4] > at __randomizedtesting.SeedInfo.seed([193346FFFDF98283]:0)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:692)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:266)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
[junit4] > at org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:369)
[junit4] > at org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:297)
[junit4] > at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1171)
[junit4] > at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:934)
[junit4] > at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:866)
[junit4] > at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:214)
[junit4] > at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:231)
[junit4] > at org.apache.solr.search.join.BlockJoinFacetDistribTest.setupCluster(BlockJoinFacetDistribTest.java:71)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > Caused by: java.net.SocketTimeoutException: Read timed out
[junit4] > at java.net.SocketInputStream.socketRead0(Native Method)
[junit4] > at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
[junit4] > at java.net.SocketInputStream.read(SocketInputStream.java:171)
[junit4] > at java.net.SocketInputStream.read(SocketInputStream.java:141)
[junit4] > at org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137)
[junit4] > at org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153)
[junit4] > at org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:280)
[junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138)
[junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56)
[junit4] > at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259)
[junit4] > at org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163)
[junit4] > at org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:157)
[junit4] > at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273)
[junit4] > at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125)
[junit4] > at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272)
[junit4] > at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186)
[junit4] > at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89)
[junit4] > at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
[junit4] > at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:571)
[junit4] > ... 36 more
[junit4] Completed [326/923 (1!)] on J1 in 96.13s, 0 tests, 1 error <<< FAILURES!
[...truncated 52862 lines...]
[JENKINS] Lucene » Lucene-Solr-Tests-8.8 - Build # 157 - Still Unstable!
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.8/157/
1 tests failed.
FAILED: org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest.testHistory
Error Message:
action did not execute
Stack Trace:
java.lang.AssertionError: action did not execute
at __randomizedtesting.SeedInfo.seed([BAFD5909562F21B3:D701FDF4EC67DEB4]:0)
at org.junit.Assert.fail(Assert.java:89)
at org.junit.Assert.assertTrue(Assert.java:42)
at org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest.testHistory(AutoscalingHistoryHandlerTest.java:283)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 14593 lines...]
[junit4] Suite: org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest
[junit4] 2> 836467 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/server/solr/configsets/_default/conf'
[junit4] 2> 836468 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_BAFD5909562F21B3-001/data-dir-66-001
[junit4] 2> 836468 WARN (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=198 numCloses=198
[junit4] 2> 836468 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 836470 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 836470 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 836471 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_BAFD5909562F21B3-001/tempDir-001
[junit4] 2> 836471 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 836475 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 836478 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 836479 WARN (ZkTestServer Run Thread) [ ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 836572 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port: 46873
[junit4] 2> 836572 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:46873
[junit4] 2> 836572 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:46873
[junit4] 2> 836572 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 46873
[junit4] 2> 836573 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 836575 INFO (zkConnectionManagerCallback-7808-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 836575 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 836577 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 836578 INFO (zkConnectionManagerCallback-7810-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 836578 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 836580 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 836581 INFO (zkConnectionManagerCallback-7812-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 836581 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 836686 INFO (jetty-launcher-7813-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 836686 INFO (jetty-launcher-7813-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 836686 INFO (jetty-launcher-7813-thread-2) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 836686 INFO (jetty-launcher-7813-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 836686 INFO (jetty-launcher-7813-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 836686 INFO (jetty-launcher-7813-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 836688 INFO (jetty-launcher-7813-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 836688 INFO (jetty-launcher-7813-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 836688 INFO (jetty-launcher-7813-thread-2) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 836688 INFO (jetty-launcher-7813-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@14ea1983{/solr,null,AVAILABLE}
[junit4] 2> 836690 INFO (jetty-launcher-7813-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 836690 INFO (jetty-launcher-7813-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 836690 INFO (jetty-launcher-7813-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 836695 INFO (jetty-launcher-7813-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@34286769{/solr,null,AVAILABLE}
[junit4] 2> 836696 INFO (jetty-launcher-7813-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@10ae12c3{SSL, (ssl, http/1.1)}{127.0.0.1:44775}
[junit4] 2> 836696 INFO (jetty-launcher-7813-thread-1) [ ] o.e.j.s.Server Started @836720ms
[junit4] 2> 836696 INFO (jetty-launcher-7813-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:46873/solr, hostPort=44775}
[junit4] 2> 836696 INFO (jetty-launcher-7813-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@58576d59{SSL, (ssl, http/1.1)}{127.0.0.1:43343}
[junit4] 2> 836696 INFO (jetty-launcher-7813-thread-2) [ ] o.e.j.s.Server Started @836721ms
[junit4] 2> 836696 INFO (jetty-launcher-7813-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:46873/solr, hostPort=43343}
[junit4] 2> 836696 ERROR (jetty-launcher-7813-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 836696 INFO (jetty-launcher-7813-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 836696 INFO (jetty-launcher-7813-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.8.0
[junit4] 2> 836696 ERROR (jetty-launcher-7813-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 836696 INFO (jetty-launcher-7813-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 836696 INFO (jetty-launcher-7813-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 836696 INFO (jetty-launcher-7813-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr
[junit4] 2> 836696 INFO (jetty-launcher-7813-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-01-26T11:48:17.479Z
[junit4] 2> 836696 INFO (jetty-launcher-7813-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.8.0
[junit4] 2> 836696 INFO (jetty-launcher-7813-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 836696 INFO (jetty-launcher-7813-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr
[junit4] 2> 836696 INFO (jetty-launcher-7813-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-01-26T11:48:17.479Z
[junit4] 2> 836701 INFO (jetty-launcher-7813-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 836703 INFO (jetty-launcher-7813-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 836704 INFO (zkConnectionManagerCallback-7817-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 836704 INFO (jetty-launcher-7813-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 836704 INFO (jetty-launcher-7813-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 836704 INFO (zkConnectionManagerCallback-7815-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 836705 INFO (jetty-launcher-7813-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 836705 INFO (jetty-launcher-7813-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 836721 WARN (jetty-launcher-7813-thread-1-SendThread(127.0.0.1:46873)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x102f57306230003.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x102f57306230003, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x102f57306230003, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 837057 INFO (jetty-launcher-7813-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 837058 WARN (jetty-launcher-7813-thread-2) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 837058 WARN (jetty-launcher-7813-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2ca3ce2f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 837058 WARN (jetty-launcher-7813-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2ca3ce2f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 837064 WARN (jetty-launcher-7813-thread-2) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 837065 WARN (jetty-launcher-7813-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@78df789e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 837065 WARN (jetty-launcher-7813-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@78df789e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 837065 INFO (jetty-launcher-7813-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46873/solr
[junit4] 2> 837067 INFO (jetty-launcher-7813-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 837071 INFO (zkConnectionManagerCallback-7831-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 837071 INFO (jetty-launcher-7813-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 837072 WARN (jetty-launcher-7813-thread-2-SendThread(127.0.0.1:46873)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x102f57306230005.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x102f57306230005, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x102f57306230005, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 837273 INFO (jetty-launcher-7813-thread-2) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 837275 INFO (zkConnectionManagerCallback-7833-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 837275 INFO (jetty-launcher-7813-thread-2) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 837335 INFO (jetty-launcher-7813-thread-2) [n:127.0.0.1:43343_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:43343_solr
[junit4] 2> 837336 INFO (jetty-launcher-7813-thread-2) [n:127.0.0.1:43343_solr ] o.a.s.c.Overseer Overseer (id=72890418364350470-127.0.0.1:43343_solr-n_0000000000) starting
[junit4] 2> 837340 INFO (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:43343_solr
[junit4] 2> 837343 INFO (jetty-launcher-7813-thread-2) [n:127.0.0.1:43343_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:43343_solr
[junit4] 2> 837344 DEBUG (OverseerAutoScalingTriggerThread-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers
[junit4] 2> 837344 DEBUG (OverseerAutoScalingTriggerThread-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1
[junit4] 2> 837345 DEBUG (OverseerAutoScalingTriggerThread-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 0
[junit4] 2> 837345 DEBUG (OverseerAutoScalingTriggerThread-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
[junit4] 2> 837346 INFO (jetty-launcher-7813-thread-2) [n:127.0.0.1:43343_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 837346 WARN (jetty-launcher-7813-thread-2) [n:127.0.0.1:43343_solr ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 837361 DEBUG (OverseerAutoScalingTriggerThread-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: []
[junit4] 2> 837362 INFO (zkCallback-7832-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 837362 DEBUG (ScheduledTrigger-7838-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 and last live nodes: 0
[junit4] 2> 837362 DEBUG (OverseerAutoScalingTriggerThread-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
[junit4] 2> 837363 DEBUG (OverseerAutoScalingTriggerThread-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
[junit4] 2> 837367 INFO (jetty-launcher-7813-thread-2) [n:127.0.0.1:43343_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 837397 INFO (jetty-launcher-7813-thread-2) [n:127.0.0.1:43343_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43343.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@705bf3dc
[junit4] 2> 837403 INFO (jetty-launcher-7813-thread-2) [n:127.0.0.1:43343_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43343.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@705bf3dc
[junit4] 2> 837404 INFO (jetty-launcher-7813-thread-2) [n:127.0.0.1:43343_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43343.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@705bf3dc
[junit4] 2> 837404 INFO (jetty-launcher-7813-thread-2) [n:127.0.0.1:43343_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_BAFD5909562F21B3-001/tempDir-001/node2
[junit4] 2> 838205 INFO (jetty-launcher-7813-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 838205 WARN (jetty-launcher-7813-thread-1) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 838206 WARN (jetty-launcher-7813-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7a6128c2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 838206 WARN (jetty-launcher-7813-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7a6128c2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 838212 WARN (jetty-launcher-7813-thread-1) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 838213 WARN (jetty-launcher-7813-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@1232cc80[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 838213 WARN (jetty-launcher-7813-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1232cc80[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 838214 INFO (jetty-launcher-7813-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46873/solr
[junit4] 2> 838215 INFO (jetty-launcher-7813-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 838219 INFO (zkConnectionManagerCallback-7853-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 838219 INFO (jetty-launcher-7813-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 838324 INFO (jetty-launcher-7813-thread-1) [n:127.0.0.1:44775_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 838325 INFO (zkConnectionManagerCallback-7855-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 838325 INFO (jetty-launcher-7813-thread-1) [n:127.0.0.1:44775_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 838329 INFO (jetty-launcher-7813-thread-1) [n:127.0.0.1:44775_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 838332 INFO (jetty-launcher-7813-thread-1) [n:127.0.0.1:44775_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:44775_solr as DOWN
[junit4] 2> 838333 INFO (jetty-launcher-7813-thread-1) [n:127.0.0.1:44775_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 838333 INFO (jetty-launcher-7813-thread-1) [n:127.0.0.1:44775_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:44775_solr
[junit4] 2> 838333 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"downnode",
[junit4] 2> "node_name":"127.0.0.1:44775_solr"} current state version: 0
[junit4] 2> 838333 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:44775_solr
[junit4] 2> 838333 INFO (zkCallback-7832-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 838334 INFO (zkCallback-7854-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 838335 INFO (jetty-launcher-7813-thread-1) [n:127.0.0.1:44775_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 838335 WARN (jetty-launcher-7813-thread-1) [n:127.0.0.1:44775_solr ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 838346 INFO (jetty-launcher-7813-thread-1) [n:127.0.0.1:44775_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 838363 DEBUG (ScheduledTrigger-7838-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 1
[junit4] 2> 838365 INFO (jetty-launcher-7813-thread-1) [n:127.0.0.1:44775_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44775.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@705bf3dc
[junit4] 2> 838373 INFO (jetty-launcher-7813-thread-1) [n:127.0.0.1:44775_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44775.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@705bf3dc
[junit4] 2> 838373 INFO (jetty-launcher-7813-thread-1) [n:127.0.0.1:44775_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44775.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@705bf3dc
[junit4] 2> 838374 INFO (jetty-launcher-7813-thread-1) [n:127.0.0.1:44775_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_BAFD5909562F21B3-001/tempDir-001/node1
[junit4] 2> 838389 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
[junit4] 2> 838390 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 838393 INFO (zkConnectionManagerCallback-7868-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 838393 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 838396 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 838398 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:46873/solr ready
[junit4] 2> 838436 INFO (OverseerThreadFactory-7840-thread-1-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection .system
[junit4] 2> 838439 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "name":".system",
[junit4] 2> "fromApi":"true",
[junit4] 2> "numShards":1,
[junit4] 2> "createNodeSet":"127.0.0.1:43343_solr",
[junit4] 2> "nrtReplicas":"1",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "replicationFactor":"1",
[junit4] 2> "operation":"create"} current state version: 0
[junit4] 2> 838439 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ClusterStateMutator building a new cName: .system
[junit4] 2> 838439 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/.system/state.json
[junit4] 2> 838548 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":".system",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:43343_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 838548 INFO (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":".system",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:43343_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 838549 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{}}
[junit4] 2> 838549 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node2":{
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:43343_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 838651 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 0
[junit4] 2> 838798 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr x:.system_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n1&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 838798 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr x:.system_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 838799 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 838802 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:43343_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":".system",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 838802 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:43343_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":".system",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 838802 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node2:{
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:43343_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "base_url":"https://127.0.0.1:43343/solr"}
[junit4] 2> 838802 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(.system//collections/.system/state.json/1 )={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"1",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"1",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"1",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node2":{
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:43343_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}}}}}
[junit4] 2> 838809 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.8.0
[junit4] 2> 838814 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but managed schema resource managed-schema not found - loading non-managed schema schema.xml instead
[junit4] 2> 838815 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=_system collection or core
[junit4] 2> 838816 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid field id
[junit4] 2> 838817 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Created and persisted managed schema znode at /configs/.system/managed-schema
[junit4] 2> 838819 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema in ZooKeeper, renamed the non-managed schema /configs/.system/schema.xml to /configs/.system/schema.xml.bak
[junit4] 2> 838820 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore '.system_shard1_replica_n1' using configuration from configset .system, trusted=true
[junit4] 2> 838820 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43343.solr.core..system.shard1.replica_n1' (registry 'solr.core..system.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@705bf3dc
[junit4] 2> 838820 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SolrCore [[.system_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_BAFD5909562F21B3-001/tempDir-001/node2/.system_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_BAFD5909562F21B3-001/tempDir-001/node2/.system_shard1_replica_n1/data/]
[junit4] 2> 838866 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 838866 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 838868 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: if 1 uncommitted docs;
[junit4] 2> 838868 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 838870 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/.system
[junit4] 2> 838870 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/.system
[junit4] 2> 838870 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/.system/managed-schema
[junit4] 2> 838871 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 838872 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 838872 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1689949778377441280
[junit4] 2> 838874 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 838874 INFO (searcherExecutor-7870-thread-1-processing-n:127.0.0.1:43343_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node2) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SolrCore [.system_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 838899 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/.system/terms/shard1 to Terms{values={core_node2=0}, version=0}
[junit4] 2> 838899 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/.system/leaders/shard1
[junit4] 2> 838903 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 1
[junit4] 2> 838904 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 838904 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 838904 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:43343/solr/.system_shard1_replica_n1/
[junit4] 2> 838905 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 838906 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SyncStrategy https://127.0.0.1:43343/solr/.system_shard1_replica_n1/ has no replicas
[junit4] 2> 838906 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/.system/leaders/shard1/leader after winning as /collections/.system/leader_elect/shard1/election/72890418364350470-core_node2-n_0000000000
[junit4] 2> 838908 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:43343/solr/.system_shard1_replica_n1/ shard1
[junit4] 2> 838908 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 838910 INFO (zkCallback-7832-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2])
[junit4] 2> 838910 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":".system",
[junit4] 2> "node_name":"127.0.0.1:43343_solr",
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "state":"active"} current state version: 0
[junit4] 2> 839012 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 2
[junit4] 2> 839012 INFO (zkCallback-7832-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2])
[junit4] 2> 839012 INFO (zkCallback-7832-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2])
[junit4] 2> 839014 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 839017 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 839019 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:43343_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":".system",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 839019 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:43343_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":".system",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 839019 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node2:{
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:43343_solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "leader":"true",
[junit4] 2> "base_url":"https://127.0.0.1:43343/solr"}
[junit4] 2> 839019 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(.system//collections/.system/state.json/3 )={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"1",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"1",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"1",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node2":{
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "leader":"true",
[junit4] 2> "node_name":"127.0.0.1:43343_solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}}}}}
[junit4] 2> 839021 INFO (qtp1387202089-12179) [n:127.0.0.1:43343_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n1&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=223
[junit4] 2> 839025 INFO (qtp441874867-12184) [n:127.0.0.1:44775_solr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 839025 INFO (qtp441874867-12184) [n:127.0.0.1:44775_solr ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 839170 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 3
[junit4] 2> 839171 INFO (zkCallback-7832-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2])
[junit4] 2> 839171 INFO (zkCallback-7832-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2])
[junit4] 2> 839173 INFO (zkCallback-7832-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2])
[junit4] 2> 839173 INFO (zkCallback-7854-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2])
[junit4] 2> 839173 INFO (qtp441874867-12184) [n:127.0.0.1:44775_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=.system&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:43343_solr&wt=javabin&version=2} status=0 QTime=747
[junit4] 2> 839174 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: .system
[junit4] 2> 839174 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 839189 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection AutoscalingHistoryHandlerTest_collection
[junit4] 2> 839189 INFO (OverseerCollectionConfigSetProcessor-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 839191 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED
[junit4] 2> 839194 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/protwords.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/protwords.txt
[junit4] 2> 839197 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/managed-schema to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/managed-schema
[junit4] 2> 839200 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/solrconfig.xml to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/solrconfig.xml
[junit4] 2> 839204 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_it.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/contractions_it.txt
[junit4] 2> 839208 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ca.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/contractions_ca.txt
[junit4] 2> 839214 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_no.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_no.txt
[junit4] 2> 839217 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stemdict_nl.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stemdict_nl.txt
[junit4] 2> 839220 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hy.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_hy.txt
[junit4] 2> 839223 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_id.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_id.txt
[junit4] 2> 839227 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_et.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_et.txt
[junit4] 2> 839228 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hi.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_hi.txt
[junit4] 2> 839233 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_da.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_da.txt
[junit4] 2> 839235 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ga.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ga.txt
[junit4] 2> 839236 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ja.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ja.txt
[junit4] 2> 839238 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_pt.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_pt.txt
[junit4] 2> 839241 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hu.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_hu.txt
[junit4] 2> 839244 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_el.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_el.txt
[junit4] 2> 839247 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ru.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ru.txt
[junit4] 2> 839249 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_tr.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_tr.txt
[junit4] 2> 839250 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ar.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ar.txt
[junit4] 2> 839254 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/userdict_ja.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/userdict_ja.txt
[junit4] 2> 839258 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_it.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_it.txt
[junit4] 2> 839261 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_eu.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_eu.txt
[junit4] 2> 839264 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_cz.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_cz.txt
[junit4] 2> 839267 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stoptags_ja.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stoptags_ja.txt
[junit4] 2> 839270 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_fr.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/contractions_fr.txt
[junit4] 2> 839275 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fa.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_fa.txt
[junit4] 2> 839280 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_de.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_de.txt
[junit4] 2> 839283 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ga.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/contractions_ga.txt
[junit4] 2> 839285 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ca.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ca.txt
[junit4] 2> 839289 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_nl.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_nl.txt
[junit4] 2> 839294 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_bg.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_bg.txt
[junit4] 2> 839297 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_es.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_es.txt
[junit4] 2> 839299 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_en.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_en.txt
[junit4] 2> 839302 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_lv.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_lv.txt
[junit4] 2> 839303 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_th.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_th.txt
[junit4] 2> 839309 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ro.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ro.txt
[junit4] 2> 839312 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fr.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_fr.txt
[junit4] 2> 839316 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_sv.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_sv.txt
[junit4] 2> 839318 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fi.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_fi.txt
[junit4] 2> 839323 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/hyphenations_ga.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/hyphenations_ga.txt
[junit4] 2> 839328 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_gl.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_gl.txt
[junit4] 2> 839363 DEBUG (ScheduledTrigger-7838-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 839480 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/synonyms.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/synonyms.txt
[junit4] 2> 839483 INFO (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/stopwords.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/stopwords.txt
[junit4] 2> 839490 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "name":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "fromApi":"true",
[junit4] 2> "numShards":"1",
[junit4] 2> "maxShardsPerNode":"3",
[junit4] 2> "createNodeSet":"127.0.0.1:44775_solr",
[junit4] 2> "nrtReplicas":"3",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "replicationFactor":"3",
[junit4] 2> "operation":"create"} current state version: 0
[junit4] 2> 839490 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ClusterStateMutator building a new cName: AutoscalingHistoryHandlerTest_collection
[junit4] 2> 839591 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/AutoscalingHistoryHandlerTest_collection/state.json
[junit4] 2> 839693 WARN (OverseerThreadFactory-7840-thread-2-processing-n:127.0.0.1:43343_solr) [n:127.0.0.1:43343_solr ] o.a.s.c.a.c.CreateCollectionCmd Specified number of replicas of 3 on collection AutoscalingHistoryHandlerTest_collection is higher than the number of Solr instances currently live or live and part of your createNodeSet(1). It's unusual to run two replica of the same slice on the same Solr-instance.
[junit4] 2> 839699 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 839699 INFO (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 839701 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{}}
[junit4] 2> 839701 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node3":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 839703 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 839704 INFO (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 839708 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node3":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 839708 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node5":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 839711 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.Overseer processMessage: queueSize: 3, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 839711 INFO (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 839718 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node5":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 839718 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node5":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node6":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 839818 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/AutoscalingHistoryHandlerTest_collection/state.json version: 0
[junit4] 2> 840052 INFO (qtp441874867-12183) [n:127.0.0.1:44775_solr x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=AutoscalingHistoryHandlerTest_collection.AUTOCREATED&newCollection=true&name=AutoscalingHistoryHandlerTest_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 840055 INFO (qtp441874867-12183) [n:127.0.0.1:44775_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node3 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 840056 INFO (qtp441874867-12182) [n:127.0.0.1:44775_solr x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node5&collection.configName=AutoscalingHistoryHandlerTest_collection.AUTOCREATED&newCollection=true&name=AutoscalingHistoryHandlerTest_collection_shard1_replica_n2&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 840057 INFO (qtp441874867-12184) [n:127.0.0.1:44775_solr x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n4 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node6&collection.configName=AutoscalingHistoryHandlerTest_collection.AUTOCREATED&newCollection=true&name=AutoscalingHistoryHandlerTest_collection_shard1_replica_n4&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 840057 INFO (qtp441874867-12182) [n:127.0.0.1:44775_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node5 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2 ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 840059 INFO (qtp441874867-12184) [n:127.0.0.1:44775_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node6 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n4 ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 840062 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "core_node_name":"core_node5",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 840062 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "core_node_name":"core_node5",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 840062 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node5:{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "base_url":"https://127.0.0.1:44775/solr"}
[junit4] 2> 840062 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(AutoscalingHistoryHandlerTest_collection//collections/AutoscalingHistoryHandlerTest_collection/state.json/1 )={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"3",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"3",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"3",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node5":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"},
[junit4] 2> "core_node6":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"}}}}}
[junit4] 2> 840063 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node3",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 840063 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node3",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 840063 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node3:{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "base_url":"https://127.0.0.1:44775/solr"}
[junit4] 2> 840063 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(AutoscalingHistoryHandlerTest_collection//collections/AutoscalingHistoryHandlerTest_collection/state.json/1 )={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"3",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"3",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"3",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"},
[junit4] 2> "core_node5":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"},
[junit4] 2> "core_node6":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"}}}}}
[junit4] 2> 840075 INFO (qtp441874867-12182) [n:127.0.0.1:44775_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node5 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.8.0
[junit4] 2> 840077 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.Overseer processMessage: queueSize: 3, message = {
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "core_node_name":"core_node6",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 840077 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "core_node_name":"core_node6",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 840077 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node6:{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "node_name":"127.0.0.1:44775_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "base_url":"https://127.0.0.1:44775/solr"}
[junit4] 2> 840077 DEBUG (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(AutoscalingHistoryHandlerTest_collection//collections/AutoscalingHistoryHandlerTest_collection/state.json/1 )={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"3",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"3",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"3",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2>
[...truncated too long message...]
avenging
[junit4] 2> 903789 INFO (jetty-closer-7920-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@10ae12c3{SSL, (ssl, http/1.1)}{127.0.0.1:0}
[junit4] 2> 903792 INFO (jetty-closer-7920-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@34286769{/solr,null,STOPPED}
[junit4] 2> 903792 INFO (jetty-closer-7920-thread-2) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 903888 INFO (jetty-closer-7920-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 903888 INFO (jetty-closer-7920-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4bd0ed1d: rootName = solr_43343, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@d56a4b4
[junit4] 2> 903893 INFO (jetty-closer-7920-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 903894 INFO (jetty-closer-7920-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1bdecfa5: rootName = solr_43343, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@53d84aff
[junit4] 2> 903895 INFO (jetty-closer-7920-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 903895 INFO (jetty-closer-7920-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@eb2f4d9: rootName = solr_43343, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@6e20f6ba
[junit4] 2> 903896 INFO (jetty-closer-7920-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null
[junit4] 2> 903897 INFO (closeThreadPool-7937-thread-2) [ ] o.a.s.c.Overseer Overseer (id=72890418364350470-127.0.0.1:43343_solr-n_0000000000) closing
[junit4] 2> 903905 INFO (OverseerStateUpdate-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [n:127.0.0.1:43343_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:43343_solr
[junit4] 2> 903922 DEBUG (closeThreadPool-7937-thread-2) [ ] o.a.s.c.a.ScheduledTriggers Shutting down scheduled thread pool executor now
[junit4] 2> 903922 DEBUG (closeThreadPool-7937-thread-2) [ ] o.a.s.c.a.ScheduledTriggers Shutting down action executor now
[junit4] 2> 903922 DEBUG (closeThreadPool-7937-thread-2) [ ] o.a.s.c.a.ScheduledTriggers Awaiting termination for action executor
[junit4] 2> 903922 INFO (OverseerAutoScalingTriggerThread-72890418364350470-127.0.0.1:43343_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 903922 DEBUG (closeThreadPool-7937-thread-2) [ ] o.a.s.c.a.ScheduledTriggers Awaiting termination for scheduled thread pool executor
[junit4] 2> 903923 DEBUG (closeThreadPool-7937-thread-2) [ ] o.a.s.c.a.ScheduledTriggers ScheduledTriggers closed completely
[junit4] 2> 903923 DEBUG (closeThreadPool-7937-thread-2) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
[junit4] 2> 903923 INFO (closeThreadPool-7937-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72890418364350470-127.0.0.1:43343_solr-n_0000000000) closing
[junit4] 2> 904024 INFO (jetty-closer-7920-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72890418364350470-127.0.0.1:43343_solr-n_0000000000) closing
[junit4] 2> 904025 INFO (jetty-closer-7920-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@58576d59{SSL, (ssl, http/1.1)}{127.0.0.1:0}
[junit4] 2> 904025 INFO (jetty-closer-7920-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@14ea1983{/solr,null,STOPPED}
[junit4] 2> 904025 INFO (jetty-closer-7920-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 904026 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 904228 WARN (ZkTestServer Run Thread) [ ] 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> 4 /solr/collections/AutoscalingHistoryHandlerTest_collection/terms/shard1
[junit4] 2> 3 /solr/packages.json
[junit4] 2> 3 /solr/security.json
[junit4] 2> 3 /solr/collections/.system/terms/shard1
[junit4] 2> 3 /solr/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/managed-schema
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 20 /solr/collections/AutoscalingHistoryHandlerTest_collection/state.json
[junit4] 2> 17 /solr/collections/.system/state.json
[junit4] 2> 12 /solr/autoscaling.json
[junit4] 2> 5 /solr/clusterstate.json
[junit4] 2> 5 /solr/clusterprops.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 36 /solr/overseer/queue
[junit4] 2> 17 /solr/live_nodes
[junit4] 2> 11 /solr/collections
[junit4] 2> 9 /solr/collections/AutoscalingHistoryHandlerTest_collection/state.json
[junit4] 2> 8 /solr/overseer/collection-queue-work
[junit4] 2> 7 /solr/collections/.system/state.json
[junit4] 2>
[junit4] 2> 904231 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:46873
[junit4] 2> 904231 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:46873
[junit4] 2> 904231 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[BAFD5909562F21B3]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 46873
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_BAFD5909562F21B3-001
[junit4] 2> Jan 26, 2021 11:49:25 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene87): {action_s=PostingsFormat(name=MockRandom), event.property.preferredOperation_ss=BlockTreeOrds(blocksize=128), event.source_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), event.property.replicaType_ss=PostingsFormat(name=MockRandom), type=PostingsFormat(name=MockRandom), before.actions_ss=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), event.property._enqueue_time__ss=PostingsFormat(name=MockRandom), error.details_t=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), stage_s=PostingsFormat(name=MockRandom), event.id_s=FST50, event.property.eventTimes_ss=PostingsFormat(name=MockRandom), source_s=FST50, event.type_s=PostingsFormat(name=MockRandom), id=FST50, event.property.nodeNames_ss=PostingsFormat(name=MockRandom), error.message_t=PostingsFormat(name=MockRandom)}, docValues:{_version_=DocValuesFormat(name=Lucene80), event.time_l=DocValuesFormat(name=Lucene80), timestamp=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=1583, maxMBSortInHeap=6.651673361842619, sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=nn-NO, timezone=Asia/Amman
[junit4] 2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation 1.8.0_252 (64-bit)/cpus=4,threads=1,free=145322384,total=519045120
[junit4] 2> NOTE: All tests run in this JVM: [CloneFieldUpdateProcessorFactoryTest, TestDistribPackageStore, DistributedExpandComponentTest, AlternateDirectoryTest, RemoteQueryErrorTest, TestNamedUpdateProcessors, PrimitiveFieldTypeTest, TestBM25SimilarityFactory, CachingDirectoryFactoryTest, TestCloudJSONFacetSKGEquiv, TestMacroExpander, SOLR749Test, ExplicitHLLTest, ClusterStateUpdateTest, TestValueSourceCache, HdfsChaosMonkeyNothingIsSafeTest, TestTolerantSearch, ZookeeperReadAPITest, ComputePlanActionTest, TestManagedSchemaAPI, LeaderElectionTest, TestUninvertingReader, ReturnFieldsTest, FieldAnalysisRequestHandlerTest, TestSimPolicyCloud, TestGraphTermsQParserPlugin, DistributedSuggestComponentTest, TestFastOutputStream, RangeFacetCloudTest, TestFieldCacheReopen, SortByFunctionTest, FuzzySearchTest, ChaosMonkeyNothingIsSafeWithPullReplicasTest, TestDynamicFieldResource, TestBinaryResponseWriter, TestPostingsSolrHighlighter, CustomHighlightComponentTest, TestLegacyBM25SimilarityFactory, HttpPartitionTest, TestOverriddenPrefixQueryForCustomFieldType, TestSubQueryTransformerCrossCore, JavabinLoaderTest, OpenExchangeRatesOrgProviderTest, MBeansHandlerTest, TestChildDocTransformer, TestHttpServletCarrier, QueryResultKeyTest, TestSchemaField, DocValuesTest, HdfsRecoveryZkTest, DirectSolrConnectionTest, TestCharFilters, TermVectorComponentTest, TestDownShardTolerantSearch, MoreLikeThisComponentTest, BlockCacheTest, SecurityHeadersTest, TestSolrDeletionPolicy1, HdfsLockFactoryTest, TestCollectionAPIs, TestCloudRecovery, SpatialFilterTest, NodeLostTriggerTest, SecurityConfHandlerTest, RegexBoostProcessorTest, SystemCollectionCompatTest, NumberUtilsTest, TestSolrJ, TestRestoreCore, TestTlogReplayVsRecovery, TestSnapshotCloudManager, DataDrivenBlockJoinTest, OverseerStatusTest, BasicDistributedZk2Test, TestFreeTextSuggestions, ShardSplitTest, AutoscalingHistoryHandlerTest]
[junit4] Completed [399/923 (1!)] on J2 in 68.38s, 1 test, 1 failure <<< FAILURES!
[...truncated 52540 lines...]