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/02/28 11:39:53 UTC

[JENKINS] Lucene » Lucene-Solr-BadApples-Tests-8.x - Build # 202 - Still Failing!

Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-BadApples-Tests-8.x/202/

All tests passed

Build Log:
[...truncated 67162 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:643: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:507: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:494: Source checkout is dirty (unversioned/missing files) after running tests!!! Offending files:
* solr/contrib/analytics/src/test-files/solr/filestore
* solr/contrib/analytics/src/test-files/solr/userfiles
* solr/contrib/dataimporthandler-extras/src/test-files/dihextras/solr/collection1/conf/dataimport.properties
* solr/contrib/dataimporthandler-extras/src/test-files/dihextras/solr/filestore
* solr/contrib/dataimporthandler-extras/src/test-files/dihextras/solr/userfiles
* solr/contrib/dataimporthandler/src/test-files/dih/solr/filestore
* solr/contrib/dataimporthandler/src/test-files/dih/solr/userfiles
* solr/contrib/extraction/src/test-files/extraction/solr/filestore
* solr/contrib/extraction/src/test-files/extraction/solr/userfiles
* solr/contrib/langid/src/test-files/langid/solr/filestore
* solr/contrib/langid/src/test-files/langid/solr/userfiles
* solr/contrib/ltr/src/test-files/solr/filestore
* solr/contrib/ltr/src/test-files/solr/userfiles
* solr/contrib/prometheus-exporter/src/test-files/solr/filestore
* solr/contrib/prometheus-exporter/src/test-files/solr/userfiles
* solr/contrib/velocity/src/test-files/velocity/solr/filestore
* solr/contrib/velocity/src/test-files/velocity/solr/userfiles
* solr/core/src/test-files/solr/filestore
* solr/core/src/test-files/solr/userfiles
* solr/solrj/src/test-files/solrj/solr/multicore/filestore
* solr/solrj/src/test-files/solrj/solr/multicore/userfiles

Total time: 73 minutes 47 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any

[JENKINS] Lucene » Lucene-Solr-BadApples-Tests-8.x - Build # 210 - Still unstable!

Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-BadApples-Tests-8.x/210/

1 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.solr.servlet.HttpSolrCallGetCoreTest

Error Message:
Timeout occurred while waiting response from server at: http://127.0.0.1:39999/solr

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: Timeout occurred while waiting response from server at: http://127.0.0.1:39999/solr
	at __randomizedtesting.SeedInfo.seed([96E9A77C44EE6AA7]: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.servlet.HttpSolrCallGetCoreTest.setupCluster(HttpSolrCallGetCoreTest.java:53)
	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 16462 lines...]
   [junit4] Suite: org.apache.solr.servlet.HttpSolrCallGetCoreTest
   [junit4]   2> 2324887 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-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-BadApples-Tests-8.x/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 2324887 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 2324888 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.servlet.HttpSolrCallGetCoreTest_96E9A77C44EE6AA7-001/data-dir-244-001
   [junit4]   2> 2324888 WARN  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=9 numCloses=9
   [junit4]   2> 2324888 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 2324889 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 2324890 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.c.SolrCloudTestCase Using per-replica state
   [junit4]   2> 2324890 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.servlet.HttpSolrCallGetCoreTest_96E9A77C44EE6AA7-001/tempDir-001
   [junit4]   2> 2324890 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2324891 INFO  (ZkTestServer Run Thread) [     ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
   [junit4]   2> 2324891 INFO  (ZkTestServer Run Thread) [     ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 2324892 WARN  (ZkTestServer Run Thread) [     ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
   [junit4]   2> 2325086 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.c.ZkTestServer start zk server on port: 34977
   [junit4]   2> 2325086 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:34977
   [junit4]   2> 2325086 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:34977
   [junit4]   2> 2325086 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 34977
   [junit4]   2> 2325089 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2325091 INFO  (zkConnectionManagerCallback-23517-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2325091 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2325093 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2325094 INFO  (zkConnectionManagerCallback-23519-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2325094 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2325095 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2325097 INFO  (zkConnectionManagerCallback-23521-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2325097 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2325199 INFO  (jetty-launcher-23522-thread-1) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 2325200 INFO  (jetty-launcher-23522-thread-1) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 2325200 INFO  (jetty-launcher-23522-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_281-b09
   [junit4]   2> 2325200 INFO  (jetty-launcher-23522-thread-1) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2325200 INFO  (jetty-launcher-23522-thread-1) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2325200 INFO  (jetty-launcher-23522-thread-1) [     ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 2325200 INFO  (jetty-launcher-23522-thread-1) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@56d7eede{/solr,null,AVAILABLE}
   [junit4]   2> 2325201 INFO  (jetty-launcher-23522-thread-1) [     ] o.e.j.s.AbstractConnector Started ServerConnector@44d5b247{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:39999}
   [junit4]   2> 2325201 INFO  (jetty-launcher-23522-thread-1) [     ] o.e.j.s.Server Started @2325232ms
   [junit4]   2> 2325201 INFO  (jetty-launcher-23522-thread-1) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:34977/solr, hostPort=39999}
   [junit4]   2> 2325201 ERROR (jetty-launcher-23522-thread-1) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 2325201 INFO  (jetty-launcher-23522-thread-1) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2325201 INFO  (jetty-launcher-23522-thread-1) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 8.9.0
   [junit4]   2> 2325201 INFO  (jetty-launcher-23522-thread-1) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2325201 INFO  (jetty-launcher-23522-thread-1) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr
   [junit4]   2> 2325201 INFO  (jetty-launcher-23522-thread-1) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2021-03-08T10:04:45.097Z
   [junit4]   2> 2325202 INFO  (jetty-launcher-23522-thread-1) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2325203 INFO  (zkConnectionManagerCallback-23524-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2325203 INFO  (jetty-launcher-23522-thread-1) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2325203 INFO  (jetty-launcher-23522-thread-1) [     ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2325207 INFO  (jetty-launcher-23522-thread-1) [     ] o.a.s.c.SolrXmlConfig Metrics collection is disabled.
   [junit4]   2> 2326141 INFO  (jetty-launcher-23522-thread-1) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 2326142 WARN  (jetty-launcher-23522-thread-1) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@554ed2b0[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2326142 WARN  (jetty-launcher-23522-thread-1) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@554ed2b0[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2326150 WARN  (jetty-launcher-23522-thread-1) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2672805c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2326150 WARN  (jetty-launcher-23522-thread-1) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2672805c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2326151 INFO  (jetty-launcher-23522-thread-1) [     ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34977/solr
   [junit4]   2> 2326158 INFO  (jetty-launcher-23522-thread-1) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2326159 INFO  (zkConnectionManagerCallback-23535-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2326159 INFO  (jetty-launcher-23522-thread-1) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2326270 INFO  (jetty-launcher-23522-thread-1) [n:127.0.0.1:39999_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2326275 INFO  (zkConnectionManagerCallback-23537-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2326275 INFO  (jetty-launcher-23522-thread-1) [n:127.0.0.1:39999_solr     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2326367 INFO  (jetty-launcher-23522-thread-1) [n:127.0.0.1:39999_solr     ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:39999_solr
   [junit4]   2> 2326367 INFO  (jetty-launcher-23522-thread-1) [n:127.0.0.1:39999_solr     ] o.a.s.c.Overseer Overseer (id=73122165950578693-127.0.0.1:39999_solr-n_0000000000) starting
   [junit4]   2> 2326382 INFO  (OverseerStateUpdate-73122165950578693-127.0.0.1:39999_solr-n_0000000000) [n:127.0.0.1:39999_solr     ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:39999_solr
   [junit4]   2> 2326382 INFO  (jetty-launcher-23522-thread-1) [n:127.0.0.1:39999_solr     ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:39999_solr
   [junit4]   2> 2326388 INFO  (jetty-launcher-23522-thread-1) [n:127.0.0.1:39999_solr     ] o.a.s.p.PackageLoader /packages.json updated to version -1
   [junit4]   2> 2326388 WARN  (jetty-launcher-23522-thread-1) [n:127.0.0.1:39999_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> 2326394 INFO  (zkCallback-23536-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 2326405 INFO  (jetty-launcher-23522-thread-1) [n:127.0.0.1:39999_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.servlet.HttpSolrCallGetCoreTest_96E9A77C44EE6AA7-001/tempDir-001/node1
   [junit4]   2> 2326418 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=1
   [junit4]   2> 2326419 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2326426 INFO  (zkConnectionManagerCallback-23552-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2326426 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2326579 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 2326581 INFO  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker) [     ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34977/solr ready
   [junit4]   2> 2326605 INFO  (OverseerThreadFactory-23544-thread-1-processing-n:127.0.0.1:39999_solr) [n:127.0.0.1:39999_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection collection1
   [junit4]   2> 2326611 WARN  (OverseerThreadFactory-23544-thread-1-processing-n:127.0.0.1:39999_solr) [n:127.0.0.1:39999_solr     ] o.a.s.c.a.c.CreateCollectionCmd Specified number of replicas of 2 on collection collection1 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> 2326613 INFO  (OverseerThreadFactory-23544-thread-1-processing-n:127.0.0.1:39999_solr) [n:127.0.0.1:39999_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"collection1_shard1_replica_n1",
   [junit4]   2>   "node_name":"127.0.0.1:39999_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:39999/solr",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2326616 INFO  (OverseerThreadFactory-23544-thread-1-processing-n:127.0.0.1:39999_solr) [n:127.0.0.1:39999_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"collection1_shard1_replica_n3",
   [junit4]   2>   "node_name":"127.0.0.1:39999_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:39999/solr",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2326628 INFO  (OverseerThreadFactory-23544-thread-1-processing-n:127.0.0.1:39999_solr) [n:127.0.0.1:39999_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"collection1_shard2_replica_n5",
   [junit4]   2>   "node_name":"127.0.0.1:39999_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:39999/solr",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2326635 INFO  (OverseerThreadFactory-23544-thread-1-processing-n:127.0.0.1:39999_solr) [n:127.0.0.1:39999_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"collection1_shard2_replica_n7",
   [junit4]   2>   "node_name":"127.0.0.1:39999_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:39999/solr",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2326637 INFO  (OverseerThreadFactory-23544-thread-1-processing-n:127.0.0.1:39999_solr) [n:127.0.0.1:39999_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"collection1_shard3_replica_n9",
   [junit4]   2>   "node_name":"127.0.0.1:39999_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:39999/solr",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "shard":"shard3",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2326643 INFO  (OverseerThreadFactory-23544-thread-1-processing-n:127.0.0.1:39999_solr) [n:127.0.0.1:39999_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"collection1_shard3_replica_n11",
   [junit4]   2>   "node_name":"127.0.0.1:39999_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:39999/solr",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "shard":"shard3",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2326653 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr    x:collection1_shard2_replica_n5 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node6&collection.configName=config&newCollection=true&name=collection1_shard2_replica_n5&action=CREATE&numShards=3&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2326653 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr    x:collection1_shard2_replica_n5 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 2326654 INFO  (qtp1242711413-40198) [n:127.0.0.1:39999_solr    x:collection1_shard2_replica_n7 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node8&collection.configName=config&newCollection=true&name=collection1_shard2_replica_n7&action=CREATE&numShards=3&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2326655 INFO  (qtp1242711413-40199) [n:127.0.0.1:39999_solr    x:collection1_shard1_replica_n3 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node4&collection.configName=config&newCollection=true&name=collection1_shard1_replica_n3&action=CREATE&numShards=3&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2326656 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr    x:collection1_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=config&newCollection=true&name=collection1_shard1_replica_n1&action=CREATE&numShards=3&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2326656 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr    x:collection1_shard3_replica_n9 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node10&collection.configName=config&newCollection=true&name=collection1_shard3_replica_n9&action=CREATE&numShards=3&collection=collection1&shard=shard3&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2326659 INFO  (qtp1242711413-40238) [n:127.0.0.1:39999_solr    x:collection1_shard3_replica_n11 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node12&collection.configName=config&newCollection=true&name=collection1_shard3_replica_n11&action=CREATE&numShards=3&collection=collection1&shard=shard3&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2326682 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
   [junit4]   2> 2326682 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
   [junit4]   2> 2326690 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
   [junit4]   2> 2326692 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 2326692 INFO  (qtp1242711413-40199) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node4 x:collection1_shard1_replica_n3 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
   [junit4]   2> 2326692 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2326692 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n1' using configuration from configset config, trusted=true
   [junit4]   2> 2326693 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrCore [[collection1_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.servlet.HttpSolrCallGetCoreTest_96E9A77C44EE6AA7-001/tempDir-001/node1/collection1_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.servlet.HttpSolrCallGetCoreTest_96E9A77C44EE6AA7-001/tempDir-001/node1/collection1_shard1_replica_n1/data/]
   [junit4]   2> 2326728 INFO  (qtp1242711413-40199) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node4 x:collection1_shard1_replica_n3 ] o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 2326729 INFO  (qtp1242711413-40199) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node4 x:collection1_shard1_replica_n3 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2326729 INFO  (qtp1242711413-40199) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node4 x:collection1_shard1_replica_n3 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n3' using configuration from configset config, trusted=true
   [junit4]   2> 2326729 INFO  (qtp1242711413-40199) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node4 x:collection1_shard1_replica_n3 ] o.a.s.c.SolrCore [[collection1_shard1_replica_n3] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.servlet.HttpSolrCallGetCoreTest_96E9A77C44EE6AA7-001/tempDir-001/node1/collection1_shard1_replica_n3], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.servlet.HttpSolrCallGetCoreTest_96E9A77C44EE6AA7-001/tempDir-001/node1/collection1_shard1_replica_n3/data/]
   [junit4]   2> 2326730 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 2326731 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2326731 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard3_replica_n9' using configuration from configset config, trusted=true
   [junit4]   2> 2326731 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.c.SolrCore [[collection1_shard3_replica_n9] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.servlet.HttpSolrCallGetCoreTest_96E9A77C44EE6AA7-001/tempDir-001/node1/collection1_shard3_replica_n9], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.servlet.HttpSolrCallGetCoreTest_96E9A77C44EE6AA7-001/tempDir-001/node1/collection1_shard3_replica_n9/data/]
   [junit4]   2> 2326733 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 2326734 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2326734 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard2_replica_n5' using configuration from configset config, trusted=true
   [junit4]   2> 2326735 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.c.SolrCore [[collection1_shard2_replica_n5] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.servlet.HttpSolrCallGetCoreTest_96E9A77C44EE6AA7-001/tempDir-001/node1/collection1_shard2_replica_n5], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.servlet.HttpSolrCallGetCoreTest_96E9A77C44EE6AA7-001/tempDir-001/node1/collection1_shard2_replica_n5/data/]
   [junit4]   2> 2326750 INFO  (qtp1242711413-40198) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n7 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
   [junit4]   2> 2326760 INFO  (qtp1242711413-40238) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node12 x:collection1_shard3_replica_n11 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
   [junit4]   2> 2326762 INFO  (qtp1242711413-40198) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n7 ] o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 2326762 INFO  (qtp1242711413-40198) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n7 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2326762 INFO  (qtp1242711413-40198) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n7 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard2_replica_n7' using configuration from configset config, trusted=true
   [junit4]   2> 2326763 INFO  (qtp1242711413-40198) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n7 ] o.a.s.c.SolrCore [[collection1_shard2_replica_n7] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.servlet.HttpSolrCallGetCoreTest_96E9A77C44EE6AA7-001/tempDir-001/node1/collection1_shard2_replica_n7], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.servlet.HttpSolrCallGetCoreTest_96E9A77C44EE6AA7-001/tempDir-001/node1/collection1_shard2_replica_n7/data/]
   [junit4]   2> 2326870 INFO  (qtp1242711413-40238) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node12 x:collection1_shard3_replica_n11 ] o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 2326870 INFO  (qtp1242711413-40238) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node12 x:collection1_shard3_replica_n11 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2326870 INFO  (qtp1242711413-40238) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node12 x:collection1_shard3_replica_n11 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard3_replica_n11' using configuration from configset config, trusted=true
   [junit4]   2> 2326871 INFO  (qtp1242711413-40238) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node12 x:collection1_shard3_replica_n11 ] o.a.s.c.SolrCore [[collection1_shard3_replica_n11] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.servlet.HttpSolrCallGetCoreTest_96E9A77C44EE6AA7-001/tempDir-001/node1/collection1_shard3_replica_n11], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.servlet.HttpSolrCallGetCoreTest_96E9A77C44EE6AA7-001/tempDir-001/node1/collection1_shard3_replica_n11/data/]
   [junit4]   2> 2326932 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2326932 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2326935 INFO  (qtp1242711413-40199) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node4 x:collection1_shard1_replica_n3 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2326935 INFO  (qtp1242711413-40199) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node4 x:collection1_shard1_replica_n3 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2326935 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2326935 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2326936 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/config
   [junit4]   2> 2326936 INFO  (qtp1242711413-40199) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node4 x:collection1_shard1_replica_n3 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2326936 INFO  (qtp1242711413-40199) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node4 x:collection1_shard1_replica_n3 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2326936 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/config
   [junit4]   2> 2326937 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 2326937 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1693657739383799808
   [junit4]   2> 2326943 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2326943 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2326944 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2326944 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2326944 INFO  (searcherExecutor-23554-thread-1-processing-n:127.0.0.1:39999_solr x:collection1_shard1_replica_n1 c:collection1 s:shard1 r:core_node2) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrCore [collection1_shard1_replica_n1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2326946 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/config
   [junit4]   2> 2326946 INFO  (qtp1242711413-40199) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node4 x:collection1_shard1_replica_n3 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/config
   [junit4]   2> 2326960 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/config
   [junit4]   2> 2326960 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 2326960 INFO  (qtp1242711413-40199) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node4 x:collection1_shard1_replica_n3 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/config
   [junit4]   2> 2326960 INFO  (qtp1242711413-40199) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node4 x:collection1_shard1_replica_n3 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 2326960 INFO  (qtp1242711413-40199) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node4 x:collection1_shard1_replica_n3 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1693657739407917056
   [junit4]   2> 2326960 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1693657739407917056
   [junit4]   2> 2326963 INFO  (searcherExecutor-23560-thread-1-processing-n:127.0.0.1:39999_solr x:collection1_shard2_replica_n5 c:collection1 s:shard2 r:core_node6) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.c.SolrCore [collection1_shard2_replica_n5]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2326966 INFO  (searcherExecutor-23556-thread-1-processing-n:127.0.0.1:39999_solr x:collection1_shard1_replica_n3 c:collection1 s:shard1 r:core_node4) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node4 x:collection1_shard1_replica_n3 ] o.a.s.c.SolrCore [collection1_shard1_replica_n3]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2326972 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/collection1/terms/shard1 to Terms{values={core_node2=0}, version=0}
   [junit4]   2> 2326972 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/collection1/leaders/shard1
   [junit4]   2> 2326974 INFO  (qtp1242711413-40199) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node4 x:collection1_shard1_replica_n3 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/collection1/terms/shard1 to Terms{values={core_node2=0, core_node4=0}, version=1}
   [junit4]   2> 2326974 INFO  (qtp1242711413-40199) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node4 x:collection1_shard1_replica_n3 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/collection1/leaders/shard1
   [junit4]   2> 2326979 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2326979 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2326980 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2326980 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2326982 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/config
   [junit4]   2> 2326983 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/config
   [junit4]   2> 2326983 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 2326983 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1693657739432034304
   [junit4]   2> 2326984 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/collection1/terms/shard2 to Terms{values={core_node6=0}, version=0}
   [junit4]   2> 2326984 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/collection1/leaders/shard2
   [junit4]   2> 2326985 INFO  (qtp1242711413-40198) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n7 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2326985 INFO  (qtp1242711413-40198) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n7 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2326986 INFO  (qtp1242711413-40198) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n7 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2326986 INFO  (qtp1242711413-40198) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n7 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2327027 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2327027 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 2327028 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:39999/solr/collection1_shard1_replica_n1/
   [junit4]   2> 2327038 INFO  (qtp1242711413-40238) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node12 x:collection1_shard3_replica_n11 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2327038 INFO  (qtp1242711413-40238) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node12 x:collection1_shard3_replica_n11 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2327039 INFO  (qtp1242711413-40238) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node12 x:collection1_shard3_replica_n11 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2327039 INFO  (qtp1242711413-40238) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node12 x:collection1_shard3_replica_n11 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2327040 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.u.PeerSync PeerSync: core=collection1_shard1_replica_n1 url=http://127.0.0.1:39999/solr  START replicas=[http://127.0.0.1:39999/solr/collection1_shard1_replica_n3/] nUpdates=100
   [junit4]   2> 2327040 INFO  (qtp1242711413-40198) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n7 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/config
   [junit4]   2> 2327040 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.u.PeerSync PeerSync: core=collection1_shard1_replica_n1 url=http://127.0.0.1:39999/solr  DONE. We have no versions. sync failed.
   [junit4]   2> 2327041 INFO  (qtp1242711413-40198) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n7 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/config
   [junit4]   2> 2327041 INFO  (searcherExecutor-23558-thread-1-processing-n:127.0.0.1:39999_solr x:collection1_shard3_replica_n9 c:collection1 s:shard3 r:core_node10) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.c.SolrCore [collection1_shard3_replica_n9]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2327041 INFO  (qtp1242711413-40198) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n7 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 2327041 INFO  (qtp1242711413-40198) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n7 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1693657739492851712
   [junit4]   2> 2327042 INFO  (qtp1242711413-40254) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node4 x:collection1_shard1_replica_n3 ] o.a.s.c.S.Request [collection1_shard1_replica_n3]  webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 2327042 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 2327042 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 2327042 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/collection1/leaders/shard1/leader after winning as /collections/collection1/leader_elect/shard1/election/73122165950578693-core_node2-n_0000000000
   [junit4]   2> 2327044 INFO  (searcherExecutor-23562-thread-1-processing-n:127.0.0.1:39999_solr x:collection1_shard2_replica_n7 c:collection1 s:shard2 r:core_node8) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n7 ] o.a.s.c.SolrCore [collection1_shard2_replica_n7]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2327044 INFO  (qtp1242711413-40238) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node12 x:collection1_shard3_replica_n11 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/config
   [junit4]   2> 2327045 INFO  (qtp1242711413-40238) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node12 x:collection1_shard3_replica_n11 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/config
   [junit4]   2> 2327045 INFO  (qtp1242711413-40238) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node12 x:collection1_shard3_replica_n11 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 2327045 INFO  (qtp1242711413-40238) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node12 x:collection1_shard3_replica_n11 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1693657739497046016
   [junit4]   2> 2327047 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:39999/solr/collection1_shard1_replica_n1/ shard1
   [junit4]   2> 2327048 INFO  (qtp1242711413-40198) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n7 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/collection1/terms/shard2 to Terms{values={core_node6=0, core_node8=0}, version=1}
   [junit4]   2> 2327048 INFO  (qtp1242711413-40198) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n7 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/collection1/leaders/shard2
   [junit4]   2> 2327048 INFO  (zkCallback-23536-thread-1) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 2327048 INFO  (zkCallback-23536-thread-3) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 2327049 INFO  (searcherExecutor-23564-thread-1-processing-n:127.0.0.1:39999_solr x:collection1_shard3_replica_n11 c:collection1 s:shard3 r:core_node12) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node12 x:collection1_shard3_replica_n11 ] o.a.s.c.SolrCore [collection1_shard3_replica_n11]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2327051 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2327051 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 2327051 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:39999/solr/collection1_shard2_replica_n5/
   [junit4]   2> 2327052 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.u.PeerSync PeerSync: core=collection1_shard2_replica_n5 url=http://127.0.0.1:39999/solr  START replicas=[http://127.0.0.1:39999/solr/collection1_shard2_replica_n7/] nUpdates=100
   [junit4]   2> 2327052 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.u.PeerSync PeerSync: core=collection1_shard2_replica_n5 url=http://127.0.0.1:39999/solr  DONE. We have no versions. sync failed.
   [junit4]   2> 2327053 INFO  (qtp1242711413-40254) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n7 ] o.a.s.c.S.Request [collection1_shard2_replica_n7]  webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 2327058 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 2327058 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 2327058 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/collection1/leaders/shard2/leader after winning as /collections/collection1/leader_elect/shard2/election/73122165950578693-core_node6-n_0000000000
   [junit4]   2> 2327060 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 2327070 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/collection1/terms/shard3 to Terms{values={core_node10=0}, version=0}
   [junit4]   2> 2327070 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/collection1/leaders/shard3
   [junit4]   2> 2327071 INFO  (qtp1242711413-40238) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node12 x:collection1_shard3_replica_n11 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/collection1/terms/shard3 to Terms{values={core_node10=0, core_node12=0}, version=1}
   [junit4]   2> 2327071 INFO  (qtp1242711413-40238) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node12 x:collection1_shard3_replica_n11 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/collection1/leaders/shard3
   [junit4]   2> 2327072 INFO  (zkCallback-23536-thread-3) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 2327072 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:39999/solr/collection1_shard2_replica_n5/ shard2
   [junit4]   2> 2327075 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr c:collection1 s:shard2 r:core_node6 x:collection1_shard2_replica_n5 ] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 2327079 INFO  (qtp1242711413-40195) [n:127.0.0.1:39999_solr     ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=config&newCollection=true&name=collection1_shard1_replica_n1&action=CREATE&numShards=3&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=423
   [junit4]   2> 2327084 INFO  (zkCallback-23536-thread-4) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 2327092 INFO  (qtp1242711413-40237) [n:127.0.0.1:39999_solr     ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node6&collection.configName=config&newCollection=true&name=collection1_shard2_replica_n5&action=CREATE&numShards=3&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT} status=0 QTime=439
   [junit4]   2> 2327095 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2327095 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 2327095 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:39999/solr/collection1_shard3_replica_n9/
   [junit4]   2> 2327095 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.u.PeerSync PeerSync: core=collection1_shard3_replica_n9 url=http://127.0.0.1:39999/solr  START replicas=[http://127.0.0.1:39999/solr/collection1_shard3_replica_n11/] nUpdates=100
   [junit4]   2> 2327095 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.u.PeerSync PeerSync: core=collection1_shard3_replica_n9 url=http://127.0.0.1:39999/solr  DONE. We have no versions. sync failed.
   [junit4]   2> 2327096 INFO  (qtp1242711413-40254) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node12 x:collection1_shard3_replica_n11 ] o.a.s.c.S.Request [collection1_shard3_replica_n11]  webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 2327096 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 2327096 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 2327096 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/collection1/leaders/shard3/leader after winning as /collections/collection1/leader_elect/shard3/election/73122165950578693-core_node10-n_0000000000
   [junit4]   2> 2327098 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:39999/solr/collection1_shard3_replica_n9/ shard3
   [junit4]   2> 2327098 INFO  (zkCallback-23536-thread-4) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 2327099 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr c:collection1 s:shard3 r:core_node10 x:collection1_shard3_replica_n9 ] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 2327101 INFO  (qtp1242711413-40197) [n:127.0.0.1:39999_solr     ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node10&collection.configName=config&newCollection=true&name=collection1_shard3_replica_n9&action=CREATE&numShards=3&collection=collection1&shard=shard3&wt=javabin&version=2&replicaType=NRT} status=0 QTime=445
   [junit4]   2> 2327102 INFO  (zkCallback-23536-thread-4) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 2327985 INFO  (zkCallback-23536-thread-4) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 2327988 INFO  (qtp1242711413-40199) [n:127.0.0.1:39999_solr     ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=config&newCollection=true&name=collection1_shard1_replica_n3&action=CREATE&numShards=3&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1332
   [junit4]   2> 2328056 INFO  (zkCallback-23536-thread-4) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 2328057 INFO  (qtp1242711413-40198) [n:127.0.0.1:39999_solr     ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=config&newCollection=true&name=collection1_shard2_replica_n7&action=CREATE&numShards=3&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1403
   [junit4]   2> 2416657 WARN  (SUITE-HttpSolrCallGetCoreTest-seed#[96E9A77C44EE6AA7]-worker-SendThread(127.0.0.1:34977)) [     ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x103c838f6b10006.
   [junit4]   2>           => EndOfStreamException: Unable to read additional data from server sessionid 0x103c838f6b10006, 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 0x103c838f6b10006, 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> 2446741 ERROR (OverseerThreadFactory-23544-thread-1-processing-n:127.0.0.1:39999_solr) [n:127.0.0.1:39999_solr     ] o.a.s.c.a.c.OverseerCollectionMessageHandler Error from shard: http://127.0.0.1:39999/solr
   [junit4]   2>           => org.apache.solr.client.solrj.SolrServerException: Timeout occurred while waiting response from server at: http://127.0.0.1:39999/solr
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:692)
   [junit4]   2> org.apache.solr.client.solrj.SolrServerException: Timeout occurred while waiting response from server at: http://127.0.0.1:39999/solr
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:692) ~[java/:?]
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:266) ~[java/:?]
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248) ~[java/:?]
   [junit4]   2> 	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1290) ~[java/:?]
   [junit4]   2> 	at org.apache.solr.handler.component.HttpShardHandlerFactory$1.request(HttpShardHandlerFactory.java:169) ~[java/:?]
   [junit4]   2> 	at org.apache.solr.handler.component.ShardRequestor.call(ShardRequestor.java:130) ~[java/:?]
   [junit4]   2> 	at org.apache.solr.handler.component.ShardRequestor.call(ShardRequestor.java:41) ~[java/:?]
   [junit4]   2> 	at java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[?:1.8.0_281]
   [junit4]   2> 	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) ~[?:1.8.0_281]
   [junit4]   2> 	at java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[?:1.8.0_281]
   [junit4]   2> 	at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:180) ~[metrics-core-4.1.5.jar:4.1.5]
   [junit4]   2> 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218) ~[java/:?]
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_281]
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_281]
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748) [?:1.8.0_281]
   [junit4]   2> Caused by: java.net.SocketTimeoutException: Read timed out
   [junit4]   2> 	at java.net.SocketInputStream.socketRead0(Native Method) ~[?:1.8.0_281]
   [junit4]   2> 	at java.net.SocketInputStream.socketRead(SocketInputStream.java:116) ~[?:1.8.0_281]
   [junit4]   2> 	at java.net.SocketInputStream.read(SocketInputStream.java:171) ~[?:1.8.0_281]
   [junit4]   2> 	at java.net.SocketInputStream.read(SocketInputStream.java:141) ~[?:1.8.0_281]
   [junit4]   2> 	at org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137) ~[httpcore-4.4.13.jar:4.4.13]
   [junit4]   2> 	at org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153) ~[httpcore-4.4.13.jar:4.4.13]
   [junit4]   2> 	at org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:280) ~[httpcore-4.4.13.jar:4.4.13]
   [junit4]   2> 	at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138) ~[httpclient-4.5.12.jar:4.5.12]
   [junit4]   2> 	at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56) ~[httpclient-4.5.12.jar:4.5.12]
   [junit4]   2> 	at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259) ~[httpcore-4.4.13.jar:4.4.13]
   [junit4]   2> 	at org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163) ~[httpcore-4.4.13.jar:4.4.13]
   [junit4]   2> 	at org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:157) ~[httpclient-4.5.12.jar:4.5.12]
   [junit4]   2> 	at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273) ~[httpcore-4.4.13.jar:4.4.13]
   [junit4]   2> 	at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125) ~[httpcore-4.4.13.jar:4.4.13]
   [junit4]   2> 	at org.apache.solr.util.stats.InstrumentedHttpRequestExecutor.execute(InstrumentedHttpRequestExecutor.java:120) ~[java/:?]
   [junit4]   2> 	at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272) ~[httpclient-4.5.12.jar:4.5.12]
   [junit4]   2> 	at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186) ~[httpclient-4.5.12.jar:4.5.12]
   [junit4]   2> 	at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89) ~[httpclient-4.5.12.jar:4.5.12]
   [junit4]   2> 	at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110) ~[httpclient-4.5.12.jar:4.5.12]
   [junit4]   2> 	at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185) ~[httpclient-4.5.12.jar:4.5.12]
   [junit4]   2> 	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83) ~[httpclient-4.5.12.jar:4.5.12]
   [junit4]   2> 	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56) ~[httpclient-4.5.12.jar:4.5.12]
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:571) ~[java/:?]
   [junit4]   2> 	... 14 more
   [junit4]   2> 2506599 ERROR (qtp1242711413-40196) [n:127.0.0.1:39999_solr     ] o.a.s.h.RequestHandlerBase org.apache.solr.common.SolrException: create the collection time out:180s
   [junit4]   2> 	at org.apache.solr.handler.admin.CollectionsHandler.sendToOCPQueue(CollectionsHandler.java:394)
   [junit4]   2> 	at org.apache.solr.handler.admin.CollectionsHandler.invokeAction(CollectionsHandler.java:299)
   [junit4]   2> 	at org.apache.solr.handler.admin.CollectionsHandler.handleRequestBody(CollectionsHandler.java:257)
   [junit4]   2> 	at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:216)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:836)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:800)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:545)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:427)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:357)
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601)
   [junit4]   2> 	at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:166)
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:548)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1612)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1434)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:501)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1582)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1349)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2> 	at org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:322)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:766)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2> 	at org.eclipse.jetty.server.Server.handle(Server.java:516)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:556)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:273)
   [junit4]   2> 	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)
   [junit4]   2> 	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:105)
   [junit4]   2> 	at org.eclipse.jetty.io.ChannelEndPoint$1.run(ChannelEndPoint.java:104)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:773)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:905)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> 2506599 INFO  (qtp1242711413-40196) [n:127.0.0.1:39999_solr     ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=config&maxShardsPerNode=6&name=collection1&nrtReplicas=2&action=CREATE&numShards=3&perReplicaState=true&wt=javabin&version=2} status=500 QTime=180009
   [junit4]   2> 2506599 ERROR (qtp1242711413-40196) [n:127.0.0.1:39999_solr     ] o.a.s.s.HttpSolrCall org.apache.solr.common.SolrException: create the collection time out:180s
   [junit4]   2> 	at org.apache.solr.handler.admin.CollectionsHandler.sendToOCPQueue(CollectionsHandler.java:394)
   [junit4]   2> 	at org.apache.solr.handler.admin.CollectionsHandler.invokeAction(CollectionsHandler.java:299)
   [junit4]   2> 	at org.apache.solr.handler.admin.CollectionsHandler.handleRequestBody(CollectionsHandler.java:257)
   [junit4]   2> 	at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:216)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:836)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:800)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:545)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:427)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:357)
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601)
   [junit4]   2> 	at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:166)
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:548)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1612)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1434)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:501)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1582)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1349)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2> 	at org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:322)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:766)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2> 	at org.eclipse.jetty.server.Server.handle(Server.java:516)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:556)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:273)
   [junit4]   2> 	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)
   [junit4]   2> 	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:105)
   [junit4]   2> 	at org.eclipse.jetty.io.ChannelEndPoint$1.run(ChannelEndPoint.java:104)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:773)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:905)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> 2506602 INFO  (jetty-closer-23589-thread-1) [     ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1412491196
   [junit4]   2> 2506602 INFO  (jetty-closer-23589-thread-1) [     ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:39999_solr
   [junit4]   2> 2506602 INFO  (jetty-closer-23589-thread-1) [     ] o.a.s.c.ZkController Publish this node as DOWN...
   [junit4]   2> 2506602 INFO  (jetty-closer-23589-thread-1) [     ] o.a.s.c.ZkController Publish node=127.0.0.1:39999_solr as DOWN
   [junit4]   2> 2506604 INFO  (coreCloseExecutor-23593-thread-1) [n:127.0.0.1:39999_solr     ] o.a.s.c.SolrCore [collection1_shard1_replica_n1]  CLOSING SolrCore org.apache.solr.core.SolrCore@77e71e79
   [junit4]   2> 2506604 INFO  (coreCloseExecutor-23593-thread-1) [n:127.0.0.1:39999_solr     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1.shard1.replica_n1 tag=SolrCore@77e71e79
   [junit4]   2> 2506604 INFO  (coreCloseExecutor-23593-thread-1) [n:127.0.0.1:39999_solr     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.collection1.shard1.leader tag=SolrCore@77e71e79
   [junit4]   2> 2506604 INFO  (coreCloseExecutor-23593-thread-2) [n:127.0.0.1:39999_solr     ] o.a.s.c.SolrCore [collection1_shard1_replica_n3]  CLOSING SolrCore org.apache.solr.core.SolrCore@494ff191
   [junit4]   2> 2506604 INFO  (coreCloseExecutor-23593-thread-2) [n:127.0.0.1:39999_solr     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1.shard1.replica_n3 tag=SolrCore@494ff191
   [junit4]   2> 2506604 INFO  (coreCloseExecutor-23593-thread-2) [n:127.0.0.1:39999_solr     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.collection1.shard1.leader tag=SolrCore@494ff191
   [junit4]   2> 2506605 INFO  (coreCloseExecutor-23593-thread-3) [n:127.0.0.1:39999_solr     ] o.a.s.c.SolrCore [collection1_shard2_replica_n5]  CLOSING SolrCore org.apache.solr.core.SolrCore@c3df79
   [junit4]   2> 2506605 INFO  (coreCloseExecutor-23593-thread-3) [n:127.0.0.1:39999_solr     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1.shard2.replica_n5 tag=SolrCore@c3df79
   [junit4]   2> 2506605 INFO  (coreCloseExecutor-23593-thread-3) [n:127.0.0.1:39999_solr     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.collection1.shard2.leader tag=SolrCore@c3df79
   [junit4]   2> 2506605 INFO  (coreCloseExecutor-23593-thread-4) [n:127.0.0.1:39999_solr     ] o.a.s.c.SolrCore [collection1_shard3_replica_n9]  CLOSING SolrCore org.apache.solr.core.SolrCore@3ee745d8
   [junit4]   2> 2506605 INFO  (coreCloseExecutor-23593-thread-4) [n:127.0.0.1:39999_solr     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1.shard3.replica_n9 tag=SolrCore@3ee745d8
   [junit4]   2> 2506605 INFO  (coreCloseExecutor-23593-thread-4) [n:127.0.0.1:39999_solr     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.collection1.shard3.leader tag=SolrCore@3ee745d8
   [junit4]   2> 2506605 INFO  (zkCallback-23536-thread-6) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 2506605 INFO  (coreCloseExecutor-23593-thread-5) [n:127.0.0.1:39999_solr     ] o.a.s.c.SolrCore [collection1_shard2_replica_n7]  CLOSING SolrCore org.apache.solr.core.SolrCore@537c238f
   [junit4]   2> 2506605 INFO  (coreCloseExecutor-23593-thread-5) [n:127.0.0.1:39999_solr     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1.shard2.replica_n7 tag=SolrCore@537c238f
   [junit4]   2> 2506605 INFO  (coreCloseExecutor-23593-thread-5) [n:127.0.0.1:39999_solr     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.collection1.shard2.leader tag=SolrCore@537c238f
   [junit4]   2> 2506607 INFO  (coreCloseExecutor-23593-thread-1) [n:127.0.0.1:39999_solr     ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED (unnecessary).
   [junit4]   2> 2506607 INFO  (coreCloseExecutor-23593-thread-2) [n:127.0.0.1:39999_solr     ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED (unnecessary).
   [junit4]   2> 2506607 INFO  (coreCloseExecutor-23593-thread-4) [n:127.0.0.1:39999_solr     ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED (unnecessary).
   [junit4]   2> 2506607 INFO  (coreCloseExecutor-23593-thread-5) [n:127.0.0.1:39999_solr     ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED (unnecessary).
   [junit4]   2> 2506607 INFO  (coreCloseExecutor-23593-thread-3) [n:127.0.0.1:39999_solr     ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED (unnecessary).
   [junit4]   2> 2506608 INFO  (coreCloseExecutor-23593-thread-6) [n:127.0.0.1:39999_solr     ] o.a.s.c.SolrCore [collection1_shard3_replica_n11]  CLOSING SolrCore org.apache.solr.core.SolrCore@4dd6cd60
   [junit4]   2> 2506608 INFO  (coreCloseExecutor-23593-thread-6) [n:127.0.0.1:39999_solr     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1.shard3.replica_n11 tag=SolrCore@4dd6cd60
   [junit4]   2> 2506608 INFO  (coreCloseExecutor-23593-thread-6) [n:127.0.0.1:39999_solr     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.collection1.shard3.leader tag=SolrCore@4dd6cd60
   [junit4]   2> 2506614 INFO  (coreCloseExecutor-23593-thread-6) [n:127.0.0.1:39999_solr     ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED (unnecessary).
   [junit4]   2> 2506616 INFO  (jetty-closer-23589-thread-1) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
   [junit4]   2> 2506616 INFO  (jetty-closer-23589-thread-1) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
   [junit4]   2> 2506616 INFO  (jetty-closer-23589-thread-1) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
   [junit4]   2> 2506616 INFO  (jetty-closer-23589-thread-1) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null
   [junit4]   2> 2506616 INFO  (closeThreadPool-23595-thread-2) [     ] o.a.s.c.Overseer Overseer (id=73122165950578693-127.0.0.1:39999_solr-n_0000000000) closing
   [junit4]   2> 2506617 INFO  (OverseerStateUpdate-73122165950578693-127.0.0.1:39999_solr-n_0000000000) [n:127.0.0.1:39999_solr     ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:39999_solr
   [junit4]   2> 2506719 ERROR (OverseerThreadFactory-23544-thread-1-processing-n:127.0.0.1:39999_solr) [n:127.0.0.1:39999_solr     ] o.a.s.c.a.c.OverseerCollectionMessageHandler Collection: collection1 operation: create failed:org.apache.solr.common.SolrException: Error fetching per-replica states
   [junit4]   2> 	at org.apache.solr.common.cloud.PerReplicaStates.fetch(PerReplicaStates.java:142)
   [junit4]   2> 	at org.apache.solr.cloud.api.collections.CreateCollectionCmd.call(CreateCollectionCmd.java:355)
   [junit4]   2> 	at org.apache.solr.cloud.api.collections.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:270)
   [junit4]   2> 	at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:524)
   [junit4]   2> 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> Caused by: org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /collections/collection1/state.json
   [junit4]   2> 	at org.apache.zookeeper.KeeperException.create(KeeperException.java:134)
   [junit4]   2> 	at org.apache.zookeeper.KeeperException.create(KeeperException.java:54)
   [junit4]   2> 	at org.apache.zookeeper.ZooKeeper.getChildren(ZooKeeper.java:2857)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient.lambda$getChildren$5(SolrZkClient.java:339)
   [junit4]   2> 	at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:79)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient.getChildren(SolrZkClient.java:339)
   [junit4]   2> 	at org.apache.solr.common.cloud.PerReplicaStates.fetch(PerReplicaStates.java:139)
   [junit4]   2> 	... 7 more
   [junit4]   2> 
   [junit4]   2> 2506719 ERROR (OverseerThreadFactory-23544-thread-1-processing-n:127.0.0.1:39999_solr) [n:127.0.0.1:39999_solr     ] o.a.s.c.OverseerTaskProcessor :org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /overseer/collection-queue-work/qnr-0000000000
   [junit4]   2> 	at org.apache.zookeeper.KeeperException.create(KeeperException.java:134)
   [junit4]   2> 	at org.apache.zookeeper.KeeperException.create(KeeperException.java:54)
   [junit4]   2> 	at org.apache.zookeeper.ZooKeeper.setData(ZooKeeper.java:2561)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient.lambda$setData$7(SolrZkClient.java:363)
   [junit4]   2> 	at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:79)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient.setData(SolrZkClient.java:363)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient.setData(SolrZkClient.java:583)
   [junit4]   2> 	at org.apache.solr.cloud.OverseerTaskQueue.remove(OverseerTaskQueue.java:118)
   [junit4]   2> 	at org.apache.solr.cloud.OverseerTaskProcessor$Runner.markTaskComplete(OverseerTaskProcessor.java:601)
   [junit4]   2> 	at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:550)
   [junit4]   2> 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$exe

[...truncated too long message...]

stSystemCollAutoCreate, OverseerSolrResponseUnsafeSerializationTest, CloneFieldUpdateProcessorFactoryTest, TestManagedSynonymGraphFilterFactory, MoveReplicaHDFSTest, LoggingHandlerTest, SearchRateTriggerTest, LargeFieldTest, TestDistributedSearch, TestCloudDeleteByQuery, SecurityHeadersTest, TestHashPartitioner, TestLegacyBM25SimilarityFactory, TriggerEventQueueTest, TestStressLucene, TestRangeQuery, TaggingAttributeTest, HttpPartitionOnCommitTest, TestReversedWildcardFilterFactory, TestMultiValuedNumericRangeQuery, TestSubQueryTransformerDistrib, DateMathParserTest, TestCollectionAPI, SuggestComponentContextFilterQueryTest, CustomTermsComponentTest, DistributedIntervalFacetingTest, ZookeeperStatusHandlerTest, TestConfigReload, SortByFunctionTest, TestJoin, TestSchemaManager, TestFieldCollectionResource, TestBulkSchemaConcurrent, CoreAdminHandlerTest, TestSolrXml, ChaosMonkeyNothingIsSafeTest, SolrGraphiteReporterTest, PackageManagerCLITest, TestPivotHelperCode, AutoScalingHandlerTest, AnalyticsQueryTest, TestSafeXMLParsing, TestBackupRepositoryFactory, TestFastOutputStream, TestZkChroot, XMLAtomicUpdateMultivalueTest, SolrCoreMetricManagerTest, TestSolrCoreProperties, TestSweetSpotSimilarityFactory, PurgeGraphTest, TestSolrConfigHandlerCloud, LeaderTragicEventTest, TestEmbeddedSolrServerAdminHandler, TestPackages, BJQFilterAccessibleTest, TestDFRSimilarityFactory, TestExactSharedStatsCache, TestTestInjection, HighlighterMaxOffsetTest, NumberUtilsTest, TestConfigSetsAPIZkFailure, TestInfoStreamLogging, TestClusterProperties, TestRestoreCore, MetricTriggerIntegrationTest, TermsComponentTest, TestGraphTermsQParserPlugin, MultiDestinationAuditLoggerTest, TestSimUtils, PeerSyncTest, TestComplexPhraseLeadingWildcard, TestUseDocValuesAsStored, CreateRoutedAliasTest, VMParamsZkACLAndCredentialsProvidersTest, AsyncCallRequestStatusResponseTest, DistributedQueryComponentOptimizationTest, PhrasesIdentificationComponentTest, ChangedSchemaMergeTest, TestFacetMethods, TestLogWatcher, TestRawTransformer, TestUnifiedSolrHighlighter, BasicFunctionalityTest, CdcrVersionReplicationTest, ShowFileRequestHandlerTest, SystemInfoHandlerTest, PeerSyncWithLeaderTest, PluginInfoTest, TestImpersonationWithHadoopAuth, TestExceedMaxTermLength, CategoryRoutedAliasUpdateProcessorTest, LeaderElectionIntegrationTest, ShardRoutingTest, TestInPlaceUpdatesRequiredField, TestConfigOverlay, NestedShardedAtomicUpdateTest, MetricsHistoryWithAuthIntegrationTest, BlockJoinFacetRandomTest, RegexBoostProcessorTest, TestSimNodeLostTrigger, TestManagedSchemaThreadSafety, StressHdfsTest, TestQuerySenderNoQuery, TestDynamicLoading, ReplicationFactorTest, ConvertedLegacyTest, CursorPagingTest, OutputWriterTest, SampleTest, SolrInfoBeanTest, SolrTestCaseJ4DeleteCoreTest, SolrTestCaseJ4Test, TestCrossCoreJoin, PathHierarchyTokenizerFactoryTest, ProtectedTermFilterFactoryTest, TestCharFilters, TestDeprecatedFilters, TestEmbeddedSolrServerConstructors, TestEmbeddedSolrServerSchemaAPI, TestJettySolrRunner, ConnectionReuseTest, ActionThrottleTest, AddReplicaTest, AliasIntegrationTest, AssignBackwardCompatibilityTest, ChaosMonkeyNothingIsSafeWithPullReplicasTest, ChaosMonkeySafeLeaderTest, CleanupOldIndexTest, CloudExitableDirectoryReaderTest, ClusterStateMockUtilTest, ClusterStateTest, ClusterStateUpdateTest, CollectionPropsTest, CollectionStateFormat2Test, ConcurrentCreateRoutedAliasTest, ConnectionManagerTest, DeleteLastCustomShardedReplicaTest, DeleteNodeTest, DeleteReplicaTest, DocValuesNotIndexedTest, LeaderElectionTest, MultiSolrCloudTestCaseTest, NodeMutatorTest, OutOfBoxZkACLAndCredentialsProvidersTest, OverriddenZkACLAndCredentialsProvidersTest, OverseerStatusTest, RecoveryAfterSoftCommitTest, SharedFSAutoReplicaFailoverTest, SliceStateTest, SplitShardTest, SystemCollectionCompatTest, TestAuthenticationFramework, TestCloudPivotFacet, TestDeleteCollectionOnDownNodes, TestDistributedMap, TestLeaderElectionWithEmptyReplica, TestPullReplica, TestPullReplicaErrorHandling, TestStressInPlaceUpdates, TlogReplayBufferedWhileIndexingTest, TriLevelCompositeIdRoutingTest, ZkCLITest, CollectionsAPIAsyncDistributedZkTest, TestReplicaProperties, NodeAddedTriggerIntegrationTest, RestoreTriggerStateTest, TestSimClusterStateProvider, TestSimComputePlanAction, TestSimDistribStateManager, TestSimExtremeIndexing, TestSimLargeCluster, RAMDirectoryFactoryTest, TestConfigSetImmutable, TestDynamicLoadingUrl, TestMinimalConfig, TestNRTOpen, TestSimpleTextCodec, TestSolrConfigHandler, TestContainerPlugin, TestSQLHandlerNonCloud, TestStressIncrementalBackup, DistributedFacetPivotLargeTest, DistributedFacetPivotSmallTest, DistributedSuggestComponentTest, ResponseBuilderTest, ResponseLogComponentTest, ShardsWhitelistTest, TermVectorComponentDistributedTest, TestLegacyField, TestLegacyNumericUtils, TestNumericRangeQuery64, SolrCloudReportersTest, TestStreamBody, TestWriterPerf, SmileWriterTest, TestCSVResponseWriter, TestGraphMLResponseWriter, TestChildDocTransformerHierarchy, TestSchemaNameResource, TestSerializedLuceneMatchVersion, DateRangeFieldTest, NotRequiredUniqueKeyTest, OpenExchangeRatesOrgProviderTest, PolyFieldTest, SpatialRPTFieldTypeTest, TestUseDocValuesAsStored2, CurrencyRangeFacetCloudTest, QueryParsingTest, SignificantTermsQParserPluginTest, SolrIndexSearcherTest, TestAddFieldRealTimeGet, TestFieldSortValues, TestLFUCache, TestSolrFieldCacheBean, TestTrieFacet, DistributedFacetSimpleRefinementLongTailTest, SpatialHeatmapFacetsTest, SimpleMLTQParserTest, TestBM25SimilarityFactory, TestNonDefinedSimilarityFactory, TestPerFieldSimilarity, TestExactStatsCache, BasicAuthStandaloneTest, TestAuthorizationFramework, HttpSolrCallGetCoreTest]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=HttpSolrCallGetCoreTest -Dtests.seed=96E9A77C44EE6AA7 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=fi -Dtests.timezone=America/Argentina/La_Rioja -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.00s J1 | HttpSolrCallGetCoreTest (suite) <<<
   [junit4]    > Throwable #1: org.apache.solr.client.solrj.SolrServerException: Timeout occurred while waiting response from server at: http://127.0.0.1:39999/solr
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([96E9A77C44EE6AA7]: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.servlet.HttpSolrCallGetCoreTest.setupCluster(HttpSolrCallGetCoreTest.java:53)
   [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 [934/934 (1!)] on J1 in 200.94s, 0 tests, 1 error <<< FAILURES!

[...truncated 50775 lines...]

[JENKINS] Lucene » Lucene-Solr-BadApples-Tests-8.x - Build # 209 - Still Failing!

Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-BadApples-Tests-8.x/209/

All tests passed

Build Log:
[...truncated 12269 lines...]
    [javac] Compiling 781 source files to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/classes/java
    [javac] /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/solrj/src/java/org/apache/solr/client/solrj/impl/PreemptiveBasicAuthClientBuilderFactory.java:150: error: cannot find symbol
    [javac]         try (BufferedReader reader = Files.newBufferedReader(Path.of(configFile), StandardCharsets.UTF_8)) {
    [javac]                                                                  ^
    [javac]   symbol:   method of(String)
    [javac]   location: interface Path
    [javac] Note: Some input files use or override a deprecated API.
    [javac] Note: Recompile with -Xlint:deprecation for details.
    [javac] Note: Some input files use unchecked or unsafe operations.
    [javac] Note: Recompile with -Xlint:unchecked for details.
    [javac] 1 error

BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:643: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:578: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:59: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build.xml:231: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/common-build.xml:550: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/common-build.xml:498: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/common-build.xml:393: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/common-build.xml:413: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/lucene/common-build.xml:581: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/lucene/common-build.xml:2083: Compile failed; see the compiler error output for details.

Total time: 13 minutes 26 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
[Checks API] No suitable checks publisher found.
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any

[JENKINS] Lucene » Lucene-Solr-BadApples-Tests-8.x - Build # 208 - Failure!

Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-BadApples-Tests-8.x/208/

All tests passed

Build Log:
[...truncated 12264 lines...]
    [javac] Compiling 781 source files to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/classes/java
    [javac] /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/solrj/src/java/org/apache/solr/client/solrj/impl/PreemptiveBasicAuthClientBuilderFactory.java:150: error: cannot find symbol
    [javac]         try (BufferedReader reader = Files.newBufferedReader(Path.of(configFile), StandardCharsets.UTF_8)) {
    [javac]                                                                  ^
    [javac]   symbol:   method of(String)
    [javac]   location: interface Path
    [javac] Note: Some input files use or override a deprecated API.
    [javac] Note: Recompile with -Xlint:deprecation for details.
    [javac] Note: Some input files use unchecked or unsafe operations.
    [javac] Note: Recompile with -Xlint:unchecked for details.
    [javac] 1 error

BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:643: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:578: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:59: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build.xml:231: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/common-build.xml:550: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/common-build.xml:498: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/common-build.xml:393: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/common-build.xml:413: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/lucene/common-build.xml:581: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/lucene/common-build.xml:2083: Compile failed; see the compiler error output for details.

Total time: 11 minutes 54 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any

[JENKINS] Lucene » Lucene-Solr-BadApples-Tests-8.x - Build # 207 - Still unstable!

Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-BadApples-Tests-8.x/207/

1 tests failed.
FAILED:  org.apache.solr.cloud.DocValuesNotIndexedTest.testGroupingDVOnlySortLast

Error Message:
Unexpected number of elements in the group for 'intGSL' size: '5' GroupValue: '966275927' rsp: {responseHeader={zkConnected=true,status=0,QTime=11,params={q=*:*,group.sort=id asc,_stateVer_=dv_coll:3,group.limit=100,rows=100,wt=javabin,version=2,group.field=intGSL,group=true}},grouped={intGSL={matches=48,groups=[{groupValue=966270113,doclist={numFound=7,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=0, intGSL=966270113, longGSL=4180084741496883248, doubleGSL=5264.0879606350345, floatGSL=925.1612, dateGSL=Fri Aug 14 15:34:26 EAT 88703750, stringGSL=base_string_538708__00007393, boolGSL=true, sortableGSL=base_string_934090__00000074, _version_=1693390160488562688, _root_=0}, SolrDocument{id=1, intGSL=966270113, longGSL=4180084741496883248, doubleGSL=5264.0879606350345, floatGSL=925.1612, dateGSL=Fri Aug 14 15:34:26 EAT 88703750, stringGSL=base_string_538708__00007393, boolGSL=false, sortableGSL=base_string_934090__00000074, _version_=1693390160489611264, _root_=1}, SolrDocument{id=2, intGSL=966270113, longGSL=4180084741496883248, doubleGSL=5264.0879606350345, floatGSL=925.1612, dateGSL=Fri Aug 14 15:34:26 EAT 88703750, stringGSL=base_string_538708__00007393, boolGSL=true, sortableGSL=base_string_934090__00000074, _version_=1693390160487514112, _root_=2}, SolrDocument{id=3, intGSL=966270113, longGSL=4180084741496883248, doubleGSL=5264.0879606350345, floatGSL=925.1612, dateGSL=Fri Aug 14 15:34:26 EAT 88703750, stringGSL=base_string_538708__00007393, boolGSL=false, sortableGSL=base_string_934090__00000074, _version_=1693390160493805568, _root_=3}, SolrDocument{id=4, intGSL=966270113, longGSL=4180084741496883248, doubleGSL=5264.0879606350345, floatGSL=925.1612, dateGSL=Fri Aug 14 15:34:26 EAT 88703750, stringGSL=base_string_538708__00007393, boolGSL=true, sortableGSL=base_string_934090__00000074, _version_=1693390160490659840, _root_=4}, SolrDocument{id=5, intGSL=966270113, longGSL=4180084741496883248, doubleGSL=5264.0879606350345, floatGSL=925.1612, dateGSL=Fri Aug 14 15:34:26 EAT 88703750, stringGSL=base_string_538708__00007393, boolGSL=false, sortableGSL=base_string_934090__00000074, _version_=1693390160490659840, _root_=5}, SolrDocument{id=6, intGSL=966270113, longGSL=4180084741496883248, doubleGSL=5264.0879606350345, floatGSL=925.1612, dateGSL=Fri Aug 14 15:34:26 EAT 88703750, stringGSL=base_string_538708__00007393, boolGSL=true, sortableGSL=base_string_934090__00000074, _version_=1693390160493805569, _root_=6}]}}, {groupValue=966275927,doclist={numFound=5,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=10, intGSL=966275927, longGSL=4180084741496889633, doubleGSL=7651.0879606350345, floatGSL=4428.161, dateGSL=Fri Aug 14 15:34:32 EAT 88703750, stringGSL=base_string_538708__00010893, boolGSL=true, sortableGSL=base_string_934090__00007167, _version_=1693390160492756993, _root_=10}, SolrDocument{id=11, intGSL=966275927, longGSL=4180084741496889633, doubleGSL=7651.0879606350345, floatGSL=4428.161, dateGSL=Fri Aug 14 15:34:32 EAT 88703750, stringGSL=base_string_538708__00010893, boolGSL=false, sortableGSL=base_string_934090__00007167, _version_=1693390160492756994, _root_=11}, SolrDocument{id=12, intGSL=966275927, longGSL=4180084741496889633, doubleGSL=7651.0879606350345, floatGSL=4428.161, dateGSL=Fri Aug 14 15:34:32 EAT 88703750, stringGSL=base_string_538708__00010893, boolGSL=true, sortableGSL=base_string_934090__00007167, _version_=1693390160490659842, _root_=12}, SolrDocument{id=13, intGSL=966275927, longGSL=4180084741496889633, doubleGSL=7651.0879606350345, floatGSL=4428.161, dateGSL=Fri Aug 14 15:34:32 EAT 88703750, stringGSL=base_string_538708__00010893, boolGSL=false, sortableGSL=base_string_934090__00007167, _version_=1693390160492756995, _root_=13}, SolrDocument{id=8, intGSL=966275927, longGSL=4180084741496889633, doubleGSL=7651.0879606350345, floatGSL=4428.161, dateGSL=Fri Aug 14 15:34:32 EAT 88703750, stringGSL=base_string_538708__00010893, boolGSL=true, sortableGSL=base_string_934090__00007167, _version_=1693390160492756992, _root_=8}]}}, {groupValue=966278750,doclist={numFound=6,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=14, intGSL=966278750, longGSL=4180084741496898297, doubleGSL=9251.087960635035, floatGSL=10220.161, dateGSL=Fri Aug 14 15:34:41 EAT 88703750, stringGSL=base_string_538708__00013637, boolGSL=true, sortableGSL=base_string_934090__00007912, _version_=1693390160492756996, _root_=14}, SolrDocument{id=15, intGSL=966278750, longGSL=4180084741496898297, doubleGSL=9251.087960635035, floatGSL=10220.161, dateGSL=Fri Aug 14 15:34:41 EAT 88703750, stringGSL=base_string_538708__00013637, boolGSL=false, sortableGSL=base_string_934090__00007912, _version_=1693390160490659843, _root_=15}, SolrDocument{id=16, intGSL=966278750, longGSL=4180084741496898297, doubleGSL=9251.087960635035, floatGSL=10220.161, dateGSL=Fri Aug 14 15:34:41 EAT 88703750, stringGSL=base_string_538708__00013637, boolGSL=true, sortableGSL=base_string_934090__00007912, _version_=1693390160490659844, _root_=16}, SolrDocument{id=17, intGSL=966278750, longGSL=4180084741496898297, doubleGSL=9251.087960635035, floatGSL=10220.161, dateGSL=Fri Aug 14 15:34:41 EAT 88703750, stringGSL=base_string_538708__00013637, boolGSL=false, sortableGSL=base_string_934090__00007912, _version_=1693390160490659841, _root_=17}, SolrDocument{id=19, intGSL=966278750, longGSL=4180084741496898297, doubleGSL=9251.087960635035, floatGSL=10220.161, dateGSL=Fri Aug 14 15:34:41 EAT 88703750, stringGSL=base_string_538708__00013637, boolGSL=false, sortableGSL=base_string_934090__00007912, _version_=1693390160490659842, _root_=19}, SolrDocument{id=20, intGSL=966278750, longGSL=4180084741496898297, doubleGSL=9251.087960635035, floatGSL=10220.161, dateGSL=Fri Aug 14 15:34:41 EAT 88703750, stringGSL=base_string_538708__00013637, boolGSL=true, sortableGSL=base_string_934090__00007912, _version_=1693390160490659845, _root_=20}]}}, {groupValue=null,doclist={numFound=6,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=10000, _version_=1693390160487514112, _root_=10000}, SolrDocument{id=10005, _version_=1693390160490659841, _root_=10005}, SolrDocument{id=10015, _version_=1693390160492756997, _root_=10015}, SolrDocument{id=10020, _version_=1693390160492756998, _root_=10020}, SolrDocument{id=10030, _version_=1693390160491708418, _root_=10030}, SolrDocument{id=10040, _version_=1693390160491708421, _root_=10040}]}}, {groupValue=966282126,doclist={numFound=6,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=21, intGSL=966282126, longGSL=4180084741496901982, doubleGSL=12982.087960635035, floatGSL=19544.162, dateGSL=Fri Aug 14 15:34:50 EAT 88703750, stringGSL=base_string_538708__00023467, boolGSL=false, sortableGSL=base_string_934090__00012064, _version_=1693390160490659843, _root_=21}, SolrDocument{id=22, intGSL=966282126, longGSL=4180084741496901982, doubleGSL=12982.087960635035, floatGSL=19544.162, dateGSL=Fri Aug 14 15:34:50 EAT 88703750, stringGSL=base_string_538708__00023467, boolGSL=true, sortableGSL=base_string_934090__00012064, _version_=1693390160491708416, _root_=22}, SolrDocument{id=23, intGSL=966282126, longGSL=4180084741496901982, doubleGSL=12982.087960635035, floatGSL=19544.162, dateGSL=Fri Aug 14 15:34:50 EAT 88703750, stringGSL=base_string_538708__00023467, boolGSL=false, sortableGSL=base_string_934090__00012064, _version_=1693390160490659844, _root_=23}, SolrDocument{id=24, intGSL=966282126, longGSL=4180084741496901982, doubleGSL=12982.087960635035, floatGSL=19544.162, dateGSL=Fri Aug 14 15:34:50 EAT 88703750, stringGSL=base_string_538708__00023467, boolGSL=true, sortableGSL=base_string_934090__00012064, _version_=1693390160492756999, _root_=24}, SolrDocument{id=25, intGSL=966282126, longGSL=4180084741496901982, doubleGSL=12982.087960635035, floatGSL=19544.162, dateGSL=Fri Aug 14 15:34:50 EAT 88703750, stringGSL=base_string_538708__00023467, boolGSL=false, sortableGSL=base_string_934090__00012064, _version_=1693390160491708416, _root_=25}, SolrDocument{id=27, intGSL=966282126, longGSL=4180084741496901982, doubleGSL=12982.087960635035, floatGSL=19544.162, dateGSL=Fri Aug 14 15:34:50 EAT 88703750, stringGSL=base_string_538708__00023467, boolGSL=false, sortableGSL=base_string_934090__00012064, _version_=1693390160493805568, _root_=27}]}}, {groupValue=966289116,doclist={numFound=5,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=28, intGSL=966289116, longGSL=4180084741496907782, doubleGSL=18755.087960635035, floatGSL=25821.162, dateGSL=Fri Aug 14 15:34:59 EAT 88703750, stringGSL=base_string_538708__00029018, boolGSL=true, sortableGSL=base_string_934090__00021777, _version_=1693390160493805569, _root_=28}, SolrDocument{id=29, intGSL=966289116, longGSL=4180084741496907782, doubleGSL=18755.087960635035, floatGSL=25821.162, dateGSL=Fri Aug 14 15:34:59 EAT 88703750, stringGSL=base_string_538708__00029018, boolGSL=false, sortableGSL=base_string_934090__00021777, _version_=1693390160491708417, _root_=29}, SolrDocument{id=32, intGSL=966289116, longGSL=4180084741496907782, doubleGSL=18755.087960635035, floatGSL=25821.162, dateGSL=Fri Aug 14 15:34:59 EAT 88703750, stringGSL=base_string_538708__00029018, boolGSL=true, sortableGSL=base_string_934090__00021777, _version_=1693390160493805570, _root_=32}, SolrDocument{id=33, intGSL=966289116, longGSL=4180084741496907782, doubleGSL=18755.087960635035, floatGSL=25821.162, dateGSL=Fri Aug 14 15:34:59 EAT 88703750, stringGSL=base_string_538708__00029018, boolGSL=false, sortableGSL=base_string_934090__00021777, _version_=1693390160491708419, _root_=33}, SolrDocument{id=34, intGSL=966289116, longGSL=4180084741496907782, doubleGSL=18755.087960635035, floatGSL=25821.162, dateGSL=Fri Aug 14 15:34:59 EAT 88703750, stringGSL=base_string_538708__00029018, boolGSL=true, sortableGSL=base_string_934090__00021777, _version_=1693390160491708417, _root_=34}]}}, {groupValue=966298520,doclist={numFound=6,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=35, intGSL=966298520, longGSL=4180084741496908803, doubleGSL=25623.087960635035, floatGSL=28333.162, dateGSL=Fri Aug 14 15:35:00 EAT 88703750, stringGSL=base_string_538708__00035900, boolGSL=false, sortableGSL=base_string_934090__00025153, _version_=1693390160491708418, _root_=35}, SolrDocument{id=36, intGSL=966298520, longGSL=4180084741496908803, doubleGSL=25623.087960635035, floatGSL=28333.162, dateGSL=Fri Aug 14 15:35:00 EAT 88703750, stringGSL=base_string_538708__00035900, boolGSL=true, sortableGSL=base_string_934090__00025153, _version_=1693390160491708419, _root_=36}, SolrDocument{id=37, intGSL=966298520, longGSL=4180084741496908803, doubleGSL=25623.087960635035, floatGSL=28333.162, dateGSL=Fri Aug 14 15:35:00 EAT 88703750, stringGSL=base_string_538708__00035900, boolGSL=false, sortableGSL=base_string_934090__00025153, _version_=1693390160491708420, _root_=37}, SolrDocument{id=38, intGSL=966298520, longGSL=4180084741496908803, doubleGSL=25623.087960635035, floatGSL=28333.162, dateGSL=Fri Aug 14 15:35:00 EAT 88703750, stringGSL=base_string_538708__00035900, boolGSL=true, sortableGSL=base_string_934090__00025153, _version_=1693390160493805571, _root_=38}, SolrDocument{id=40, intGSL=966298520, longGSL=4180084741496908803, doubleGSL=25623.087960635035, floatGSL=28333.162, dateGSL=Fri Aug 14 15:35:00 EAT 88703750, stringGSL=base_string_538708__00035900, boolGSL=true, sortableGSL=base_string_934090__00025153, _version_=1693390160493805572, _root_=40}, SolrDocument{id=41, intGSL=966298520, longGSL=4180084741496908803, doubleGSL=25623.087960635035, floatGSL=28333.162, dateGSL=Fri Aug 14 15:35:00 EAT 88703750, stringGSL=base_string_538708__00035900, boolGSL=false, sortableGSL=base_string_934090__00025153, _version_=1693390160491708420, _root_=41}]}}, {groupValue=966308162,doclist={numFound=7,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=42, intGSL=966308162, longGSL=4180084741496918092, doubleGSL=26797.087960635035, floatGSL=31428.162, dateGSL=Fri Aug 14 15:35:07 EAT 88703750, stringGSL=base_string_538708__00041597, boolGSL=true, sortableGSL=base_string_934090__00027679, _version_=1693390160493805573, _root_=42}, SolrDocument{id=43, intGSL=966308162, longGSL=4180084741496918092, doubleGSL=26797.087960635035, floatGSL=31428.162, dateGSL=Fri Aug 14 15:35:07 EAT 88703750, stringGSL=base_string_538708__00041597, boolGSL=false, sortableGSL=base_string_934090__00027679, _version_=1693390160491708421, _root_=43}, SolrDocument{id=44, intGSL=966308162, longGSL=4180084741496918092, doubleGSL=26797.087960635035, floatGSL=31428.162, dateGSL=Fri Aug 14 15:35:07 EAT 88703750, stringGSL=base_string_538708__00041597, boolGSL=true, sortableGSL=base_string_934090__00027679, _version_=1693390160491708422, _root_=44}, SolrDocument{id=45, intGSL=966308162, longGSL=4180084741496918092, doubleGSL=26797.087960635035, floatGSL=31428.162, dateGSL=Fri Aug 14 15:35:07 EAT 88703750, stringGSL=base_string_538708__00041597, boolGSL=false, sortableGSL=base_string_934090__00027679, _version_=1693390160491708422, _root_=45}, SolrDocument{id=46, intGSL=966308162, longGSL=4180084741496918092, doubleGSL=26797.087960635035, floatGSL=31428.162, dateGSL=Fri Aug 14 15:35:07 EAT 88703750, stringGSL=base_string_538708__00041597, boolGSL=true, sortableGSL=base_string_934090__00027679, _version_=1693390160491708423, _root_=46}, SolrDocument{id=47, intGSL=966308162, longGSL=4180084741496918092, doubleGSL=26797.087960635035, floatGSL=31428.162, dateGSL=Fri Aug 14 15:35:07 EAT 88703750, stringGSL=base_string_538708__00041597, boolGSL=false, sortableGSL=base_string_934090__00027679, _version_=1693390160491708424, _root_=47}, SolrDocument{id=48, intGSL=966308162, longGSL=4180084741496918092, doubleGSL=26797.087960635035, floatGSL=31428.162, dateGSL=Fri Aug 14 15:35:07 EAT 88703750, stringGSL=base_string_538708__00041597, boolGSL=true, sortableGSL=base_string_934090__00027679, _version_=1693390160493805574, _root_=48}]}}]}}}

Stack Trace:
java.lang.AssertionError: Unexpected number of elements in the group for 'intGSL' size: '5' GroupValue: '966275927' rsp: {responseHeader={zkConnected=true,status=0,QTime=11,params={q=*:*,group.sort=id asc,_stateVer_=dv_coll:3,group.limit=100,rows=100,wt=javabin,version=2,group.field=intGSL,group=true}},grouped={intGSL={matches=48,groups=[{groupValue=966270113,doclist={numFound=7,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=0, intGSL=966270113, longGSL=4180084741496883248, doubleGSL=5264.0879606350345, floatGSL=925.1612, dateGSL=Fri Aug 14 15:34:26 EAT 88703750, stringGSL=base_string_538708__00007393, boolGSL=true, sortableGSL=base_string_934090__00000074, _version_=1693390160488562688, _root_=0}, SolrDocument{id=1, intGSL=966270113, longGSL=4180084741496883248, doubleGSL=5264.0879606350345, floatGSL=925.1612, dateGSL=Fri Aug 14 15:34:26 EAT 88703750, stringGSL=base_string_538708__00007393, boolGSL=false, sortableGSL=base_string_934090__00000074, _version_=1693390160489611264, _root_=1}, SolrDocument{id=2, intGSL=966270113, longGSL=4180084741496883248, doubleGSL=5264.0879606350345, floatGSL=925.1612, dateGSL=Fri Aug 14 15:34:26 EAT 88703750, stringGSL=base_string_538708__00007393, boolGSL=true, sortableGSL=base_string_934090__00000074, _version_=1693390160487514112, _root_=2}, SolrDocument{id=3, intGSL=966270113, longGSL=4180084741496883248, doubleGSL=5264.0879606350345, floatGSL=925.1612, dateGSL=Fri Aug 14 15:34:26 EAT 88703750, stringGSL=base_string_538708__00007393, boolGSL=false, sortableGSL=base_string_934090__00000074, _version_=1693390160493805568, _root_=3}, SolrDocument{id=4, intGSL=966270113, longGSL=4180084741496883248, doubleGSL=5264.0879606350345, floatGSL=925.1612, dateGSL=Fri Aug 14 15:34:26 EAT 88703750, stringGSL=base_string_538708__00007393, boolGSL=true, sortableGSL=base_string_934090__00000074, _version_=1693390160490659840, _root_=4}, SolrDocument{id=5, intGSL=966270113, longGSL=4180084741496883248, doubleGSL=5264.0879606350345, floatGSL=925.1612, dateGSL=Fri Aug 14 15:34:26 EAT 88703750, stringGSL=base_string_538708__00007393, boolGSL=false, sortableGSL=base_string_934090__00000074, _version_=1693390160490659840, _root_=5}, SolrDocument{id=6, intGSL=966270113, longGSL=4180084741496883248, doubleGSL=5264.0879606350345, floatGSL=925.1612, dateGSL=Fri Aug 14 15:34:26 EAT 88703750, stringGSL=base_string_538708__00007393, boolGSL=true, sortableGSL=base_string_934090__00000074, _version_=1693390160493805569, _root_=6}]}}, {groupValue=966275927,doclist={numFound=5,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=10, intGSL=966275927, longGSL=4180084741496889633, doubleGSL=7651.0879606350345, floatGSL=4428.161, dateGSL=Fri Aug 14 15:34:32 EAT 88703750, stringGSL=base_string_538708__00010893, boolGSL=true, sortableGSL=base_string_934090__00007167, _version_=1693390160492756993, _root_=10}, SolrDocument{id=11, intGSL=966275927, longGSL=4180084741496889633, doubleGSL=7651.0879606350345, floatGSL=4428.161, dateGSL=Fri Aug 14 15:34:32 EAT 88703750, stringGSL=base_string_538708__00010893, boolGSL=false, sortableGSL=base_string_934090__00007167, _version_=1693390160492756994, _root_=11}, SolrDocument{id=12, intGSL=966275927, longGSL=4180084741496889633, doubleGSL=7651.0879606350345, floatGSL=4428.161, dateGSL=Fri Aug 14 15:34:32 EAT 88703750, stringGSL=base_string_538708__00010893, boolGSL=true, sortableGSL=base_string_934090__00007167, _version_=1693390160490659842, _root_=12}, SolrDocument{id=13, intGSL=966275927, longGSL=4180084741496889633, doubleGSL=7651.0879606350345, floatGSL=4428.161, dateGSL=Fri Aug 14 15:34:32 EAT 88703750, stringGSL=base_string_538708__00010893, boolGSL=false, sortableGSL=base_string_934090__00007167, _version_=1693390160492756995, _root_=13}, SolrDocument{id=8, intGSL=966275927, longGSL=4180084741496889633, doubleGSL=7651.0879606350345, floatGSL=4428.161, dateGSL=Fri Aug 14 15:34:32 EAT 88703750, stringGSL=base_string_538708__00010893, boolGSL=true, sortableGSL=base_string_934090__00007167, _version_=1693390160492756992, _root_=8}]}}, {groupValue=966278750,doclist={numFound=6,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=14, intGSL=966278750, longGSL=4180084741496898297, doubleGSL=9251.087960635035, floatGSL=10220.161, dateGSL=Fri Aug 14 15:34:41 EAT 88703750, stringGSL=base_string_538708__00013637, boolGSL=true, sortableGSL=base_string_934090__00007912, _version_=1693390160492756996, _root_=14}, SolrDocument{id=15, intGSL=966278750, longGSL=4180084741496898297, doubleGSL=9251.087960635035, floatGSL=10220.161, dateGSL=Fri Aug 14 15:34:41 EAT 88703750, stringGSL=base_string_538708__00013637, boolGSL=false, sortableGSL=base_string_934090__00007912, _version_=1693390160490659843, _root_=15}, SolrDocument{id=16, intGSL=966278750, longGSL=4180084741496898297, doubleGSL=9251.087960635035, floatGSL=10220.161, dateGSL=Fri Aug 14 15:34:41 EAT 88703750, stringGSL=base_string_538708__00013637, boolGSL=true, sortableGSL=base_string_934090__00007912, _version_=1693390160490659844, _root_=16}, SolrDocument{id=17, intGSL=966278750, longGSL=4180084741496898297, doubleGSL=9251.087960635035, floatGSL=10220.161, dateGSL=Fri Aug 14 15:34:41 EAT 88703750, stringGSL=base_string_538708__00013637, boolGSL=false, sortableGSL=base_string_934090__00007912, _version_=1693390160490659841, _root_=17}, SolrDocument{id=19, intGSL=966278750, longGSL=4180084741496898297, doubleGSL=9251.087960635035, floatGSL=10220.161, dateGSL=Fri Aug 14 15:34:41 EAT 88703750, stringGSL=base_string_538708__00013637, boolGSL=false, sortableGSL=base_string_934090__00007912, _version_=1693390160490659842, _root_=19}, SolrDocument{id=20, intGSL=966278750, longGSL=4180084741496898297, doubleGSL=9251.087960635035, floatGSL=10220.161, dateGSL=Fri Aug 14 15:34:41 EAT 88703750, stringGSL=base_string_538708__00013637, boolGSL=true, sortableGSL=base_string_934090__00007912, _version_=1693390160490659845, _root_=20}]}}, {groupValue=null,doclist={numFound=6,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=10000, _version_=1693390160487514112, _root_=10000}, SolrDocument{id=10005, _version_=1693390160490659841, _root_=10005}, SolrDocument{id=10015, _version_=1693390160492756997, _root_=10015}, SolrDocument{id=10020, _version_=1693390160492756998, _root_=10020}, SolrDocument{id=10030, _version_=1693390160491708418, _root_=10030}, SolrDocument{id=10040, _version_=1693390160491708421, _root_=10040}]}}, {groupValue=966282126,doclist={numFound=6,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=21, intGSL=966282126, longGSL=4180084741496901982, doubleGSL=12982.087960635035, floatGSL=19544.162, dateGSL=Fri Aug 14 15:34:50 EAT 88703750, stringGSL=base_string_538708__00023467, boolGSL=false, sortableGSL=base_string_934090__00012064, _version_=1693390160490659843, _root_=21}, SolrDocument{id=22, intGSL=966282126, longGSL=4180084741496901982, doubleGSL=12982.087960635035, floatGSL=19544.162, dateGSL=Fri Aug 14 15:34:50 EAT 88703750, stringGSL=base_string_538708__00023467, boolGSL=true, sortableGSL=base_string_934090__00012064, _version_=1693390160491708416, _root_=22}, SolrDocument{id=23, intGSL=966282126, longGSL=4180084741496901982, doubleGSL=12982.087960635035, floatGSL=19544.162, dateGSL=Fri Aug 14 15:34:50 EAT 88703750, stringGSL=base_string_538708__00023467, boolGSL=false, sortableGSL=base_string_934090__00012064, _version_=1693390160490659844, _root_=23}, SolrDocument{id=24, intGSL=966282126, longGSL=4180084741496901982, doubleGSL=12982.087960635035, floatGSL=19544.162, dateGSL=Fri Aug 14 15:34:50 EAT 88703750, stringGSL=base_string_538708__00023467, boolGSL=true, sortableGSL=base_string_934090__00012064, _version_=1693390160492756999, _root_=24}, SolrDocument{id=25, intGSL=966282126, longGSL=4180084741496901982, doubleGSL=12982.087960635035, floatGSL=19544.162, dateGSL=Fri Aug 14 15:34:50 EAT 88703750, stringGSL=base_string_538708__00023467, boolGSL=false, sortableGSL=base_string_934090__00012064, _version_=1693390160491708416, _root_=25}, SolrDocument{id=27, intGSL=966282126, longGSL=4180084741496901982, doubleGSL=12982.087960635035, floatGSL=19544.162, dateGSL=Fri Aug 14 15:34:50 EAT 88703750, stringGSL=base_string_538708__00023467, boolGSL=false, sortableGSL=base_string_934090__00012064, _version_=1693390160493805568, _root_=27}]}}, {groupValue=966289116,doclist={numFound=5,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=28, intGSL=966289116, longGSL=4180084741496907782, doubleGSL=18755.087960635035, floatGSL=25821.162, dateGSL=Fri Aug 14 15:34:59 EAT 88703750, stringGSL=base_string_538708__00029018, boolGSL=true, sortableGSL=base_string_934090__00021777, _version_=1693390160493805569, _root_=28}, SolrDocument{id=29, intGSL=966289116, longGSL=4180084741496907782, doubleGSL=18755.087960635035, floatGSL=25821.162, dateGSL=Fri Aug 14 15:34:59 EAT 88703750, stringGSL=base_string_538708__00029018, boolGSL=false, sortableGSL=base_string_934090__00021777, _version_=1693390160491708417, _root_=29}, SolrDocument{id=32, intGSL=966289116, longGSL=4180084741496907782, doubleGSL=18755.087960635035, floatGSL=25821.162, dateGSL=Fri Aug 14 15:34:59 EAT 88703750, stringGSL=base_string_538708__00029018, boolGSL=true, sortableGSL=base_string_934090__00021777, _version_=1693390160493805570, _root_=32}, SolrDocument{id=33, intGSL=966289116, longGSL=4180084741496907782, doubleGSL=18755.087960635035, floatGSL=25821.162, dateGSL=Fri Aug 14 15:34:59 EAT 88703750, stringGSL=base_string_538708__00029018, boolGSL=false, sortableGSL=base_string_934090__00021777, _version_=1693390160491708419, _root_=33}, SolrDocument{id=34, intGSL=966289116, longGSL=4180084741496907782, doubleGSL=18755.087960635035, floatGSL=25821.162, dateGSL=Fri Aug 14 15:34:59 EAT 88703750, stringGSL=base_string_538708__00029018, boolGSL=true, sortableGSL=base_string_934090__00021777, _version_=1693390160491708417, _root_=34}]}}, {groupValue=966298520,doclist={numFound=6,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=35, intGSL=966298520, longGSL=4180084741496908803, doubleGSL=25623.087960635035, floatGSL=28333.162, dateGSL=Fri Aug 14 15:35:00 EAT 88703750, stringGSL=base_string_538708__00035900, boolGSL=false, sortableGSL=base_string_934090__00025153, _version_=1693390160491708418, _root_=35}, SolrDocument{id=36, intGSL=966298520, longGSL=4180084741496908803, doubleGSL=25623.087960635035, floatGSL=28333.162, dateGSL=Fri Aug 14 15:35:00 EAT 88703750, stringGSL=base_string_538708__00035900, boolGSL=true, sortableGSL=base_string_934090__00025153, _version_=1693390160491708419, _root_=36}, SolrDocument{id=37, intGSL=966298520, longGSL=4180084741496908803, doubleGSL=25623.087960635035, floatGSL=28333.162, dateGSL=Fri Aug 14 15:35:00 EAT 88703750, stringGSL=base_string_538708__00035900, boolGSL=false, sortableGSL=base_string_934090__00025153, _version_=1693390160491708420, _root_=37}, SolrDocument{id=38, intGSL=966298520, longGSL=4180084741496908803, doubleGSL=25623.087960635035, floatGSL=28333.162, dateGSL=Fri Aug 14 15:35:00 EAT 88703750, stringGSL=base_string_538708__00035900, boolGSL=true, sortableGSL=base_string_934090__00025153, _version_=1693390160493805571, _root_=38}, SolrDocument{id=40, intGSL=966298520, longGSL=4180084741496908803, doubleGSL=25623.087960635035, floatGSL=28333.162, dateGSL=Fri Aug 14 15:35:00 EAT 88703750, stringGSL=base_string_538708__00035900, boolGSL=true, sortableGSL=base_string_934090__00025153, _version_=1693390160493805572, _root_=40}, SolrDocument{id=41, intGSL=966298520, longGSL=4180084741496908803, doubleGSL=25623.087960635035, floatGSL=28333.162, dateGSL=Fri Aug 14 15:35:00 EAT 88703750, stringGSL=base_string_538708__00035900, boolGSL=false, sortableGSL=base_string_934090__00025153, _version_=1693390160491708420, _root_=41}]}}, {groupValue=966308162,doclist={numFound=7,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=42, intGSL=966308162, longGSL=4180084741496918092, doubleGSL=26797.087960635035, floatGSL=31428.162, dateGSL=Fri Aug 14 15:35:07 EAT 88703750, stringGSL=base_string_538708__00041597, boolGSL=true, sortableGSL=base_string_934090__00027679, _version_=1693390160493805573, _root_=42}, SolrDocument{id=43, intGSL=966308162, longGSL=4180084741496918092, doubleGSL=26797.087960635035, floatGSL=31428.162, dateGSL=Fri Aug 14 15:35:07 EAT 88703750, stringGSL=base_string_538708__00041597, boolGSL=false, sortableGSL=base_string_934090__00027679, _version_=1693390160491708421, _root_=43}, SolrDocument{id=44, intGSL=966308162, longGSL=4180084741496918092, doubleGSL=26797.087960635035, floatGSL=31428.162, dateGSL=Fri Aug 14 15:35:07 EAT 88703750, stringGSL=base_string_538708__00041597, boolGSL=true, sortableGSL=base_string_934090__00027679, _version_=1693390160491708422, _root_=44}, SolrDocument{id=45, intGSL=966308162, longGSL=4180084741496918092, doubleGSL=26797.087960635035, floatGSL=31428.162, dateGSL=Fri Aug 14 15:35:07 EAT 88703750, stringGSL=base_string_538708__00041597, boolGSL=false, sortableGSL=base_string_934090__00027679, _version_=1693390160491708422, _root_=45}, SolrDocument{id=46, intGSL=966308162, longGSL=4180084741496918092, doubleGSL=26797.087960635035, floatGSL=31428.162, dateGSL=Fri Aug 14 15:35:07 EAT 88703750, stringGSL=base_string_538708__00041597, boolGSL=true, sortableGSL=base_string_934090__00027679, _version_=1693390160491708423, _root_=46}, SolrDocument{id=47, intGSL=966308162, longGSL=4180084741496918092, doubleGSL=26797.087960635035, floatGSL=31428.162, dateGSL=Fri Aug 14 15:35:07 EAT 88703750, stringGSL=base_string_538708__00041597, boolGSL=false, sortableGSL=base_string_934090__00027679, _version_=1693390160491708424, _root_=47}, SolrDocument{id=48, intGSL=966308162, longGSL=4180084741496918092, doubleGSL=26797.087960635035, floatGSL=31428.162, dateGSL=Fri Aug 14 15:35:07 EAT 88703750, stringGSL=base_string_538708__00041597, boolGSL=true, sortableGSL=base_string_934090__00027679, _version_=1693390160493805574, _root_=48}]}}]}}}
	at __randomizedtesting.SeedInfo.seed([BF30E7EEE99EC3B2:AC3A3DD8839A6EC]:0)
	at org.junit.Assert.fail(Assert.java:89)
	at org.apache.solr.cloud.DocValuesNotIndexedTest.doGroupingDvOnly(DocValuesNotIndexedTest.java:404)
	at org.apache.solr.cloud.DocValuesNotIndexedTest.testGroupingDVOnlySortLast(DocValuesNotIndexedTest.java:332)
	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 15051 lines...]
   [junit4] Suite: org.apache.solr.cloud.DocValuesNotIndexedTest
   [junit4]   2> 1391967 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-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-BadApples-Tests-8.x/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 1391968 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_BF30E7EEE99EC3B2-001/data-dir-137-001
   [junit4]   2> 1391968 WARN  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=10 numCloses=10
   [junit4]   2> 1391968 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1391970 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-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> 1391970 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1391970 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.c.SolrCloudTestCase Using per-replica state
   [junit4]   2> 1391970 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_BF30E7EEE99EC3B2-001/tempDir-001
   [junit4]   2> 1391970 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1391971 INFO  (ZkTestServer Run Thread) [     ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
   [junit4]   2> 1391971 INFO  (ZkTestServer Run Thread) [     ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 1391971 WARN  (ZkTestServer Run Thread) [     ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
   [junit4]   2> 1392071 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.c.ZkTestServer start zk server on port: 34619
   [junit4]   2> 1392071 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:34619
   [junit4]   2> 1392071 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:34619
   [junit4]   2> 1392071 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 34619
   [junit4]   2> 1392072 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1392075 INFO  (zkConnectionManagerCallback-12188-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1392075 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1392077 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1392078 INFO  (zkConnectionManagerCallback-12190-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1392078 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1392079 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1392079 INFO  (zkConnectionManagerCallback-12192-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1392079 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1392182 INFO  (jetty-launcher-12193-thread-2) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1392182 INFO  (jetty-launcher-12193-thread-2) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 1392182 INFO  (jetty-launcher-12193-thread-1) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1392183 INFO  (jetty-launcher-12193-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_281-b09
   [junit4]   2> 1392183 INFO  (jetty-launcher-12193-thread-1) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 1392183 INFO  (jetty-launcher-12193-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_281-b09
   [junit4]   2> 1392184 INFO  (jetty-launcher-12193-thread-2) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1392184 INFO  (jetty-launcher-12193-thread-2) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1392184 INFO  (jetty-launcher-12193-thread-2) [     ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1392185 INFO  (jetty-launcher-12193-thread-1) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1392185 INFO  (jetty-launcher-12193-thread-1) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1392185 INFO  (jetty-launcher-12193-thread-1) [     ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1392185 INFO  (jetty-launcher-12193-thread-2) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3fc226e{/solr,null,AVAILABLE}
   [junit4]   2> 1392185 INFO  (jetty-launcher-12193-thread-1) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7251f569{/solr,null,AVAILABLE}
   [junit4]   2> 1392186 INFO  (jetty-launcher-12193-thread-1) [     ] o.e.j.s.AbstractConnector Started ServerConnector@7b34a8d7{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:38073}
   [junit4]   2> 1392186 INFO  (jetty-launcher-12193-thread-1) [     ] o.e.j.s.Server Started @1392220ms
   [junit4]   2> 1392186 INFO  (jetty-launcher-12193-thread-1) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:34619/solr, hostPort=38073}
   [junit4]   2> 1392186 ERROR (jetty-launcher-12193-thread-1) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 1392186 INFO  (jetty-launcher-12193-thread-1) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1392186 INFO  (jetty-launcher-12193-thread-1) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.9.0
   [junit4]   2> 1392186 INFO  (jetty-launcher-12193-thread-1) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1392186 INFO  (jetty-launcher-12193-thread-1) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr
   [junit4]   2> 1392186 INFO  (jetty-launcher-12193-thread-1) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2021-03-05T11:11:42.058Z
   [junit4]   2> 1392186 INFO  (jetty-launcher-12193-thread-2) [     ] o.e.j.s.AbstractConnector Started ServerConnector@2caf50fb{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:46221}
   [junit4]   2> 1392186 INFO  (jetty-launcher-12193-thread-2) [     ] o.e.j.s.Server Started @1392220ms
   [junit4]   2> 1392186 INFO  (jetty-launcher-12193-thread-2) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:34619/solr, hostPort=46221}
   [junit4]   2> 1392186 ERROR (jetty-launcher-12193-thread-2) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 1392186 INFO  (jetty-launcher-12193-thread-2) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1392186 INFO  (jetty-launcher-12193-thread-2) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.9.0
   [junit4]   2> 1392186 INFO  (jetty-launcher-12193-thread-2) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1392186 INFO  (jetty-launcher-12193-thread-2) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr
   [junit4]   2> 1392186 INFO  (jetty-launcher-12193-thread-2) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2021-03-05T11:11:42.058Z
   [junit4]   2> 1392188 INFO  (jetty-launcher-12193-thread-1) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1392190 INFO  (jetty-launcher-12193-thread-2) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1392190 INFO  (zkConnectionManagerCallback-12195-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1392190 INFO  (jetty-launcher-12193-thread-1) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1392190 INFO  (zkConnectionManagerCallback-12197-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1392191 INFO  (jetty-launcher-12193-thread-2) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1392191 INFO  (jetty-launcher-12193-thread-1) [     ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1392191 INFO  (jetty-launcher-12193-thread-2) [     ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1392195 INFO  (jetty-launcher-12193-thread-2) [     ] o.a.s.c.SolrXmlConfig Metrics collection is disabled.
   [junit4]   2> 1392195 INFO  (jetty-launcher-12193-thread-1) [     ] o.a.s.c.SolrXmlConfig Metrics collection is disabled.
   [junit4]   2> 1392196 WARN  (jetty-launcher-12193-thread-2-SendThread(127.0.0.1:34619)) [     ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x103b9032e490004.
   [junit4]   2>           => EndOfStreamException: Unable to read additional data from server sessionid 0x103b9032e490004, 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 0x103b9032e490004, 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> 1392714 INFO  (jetty-launcher-12193-thread-1) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1392715 WARN  (jetty-launcher-12193-thread-1) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@1ec5cfb9[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1392715 WARN  (jetty-launcher-12193-thread-1) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1ec5cfb9[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1392717 WARN  (jetty-launcher-12193-thread-1) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@37122638[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1392717 WARN  (jetty-launcher-12193-thread-1) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@37122638[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1392719 INFO  (jetty-launcher-12193-thread-1) [     ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34619/solr
   [junit4]   2> 1392722 INFO  (jetty-launcher-12193-thread-1) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1392724 INFO  (zkConnectionManagerCallback-12211-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1392724 INFO  (jetty-launcher-12193-thread-1) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1392826 INFO  (jetty-launcher-12193-thread-1) [n:127.0.0.1:38073_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1392827 INFO  (zkConnectionManagerCallback-12213-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1392827 INFO  (jetty-launcher-12193-thread-1) [n:127.0.0.1:38073_solr     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1392890 INFO  (jetty-launcher-12193-thread-1) [n:127.0.0.1:38073_solr     ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:38073_solr
   [junit4]   2> 1392890 INFO  (jetty-launcher-12193-thread-1) [n:127.0.0.1:38073_solr     ] o.a.s.c.Overseer Overseer (id=73105442280636422-127.0.0.1:38073_solr-n_0000000000) starting
   [junit4]   2> 1392891 INFO  (jetty-launcher-12193-thread-2) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1392891 WARN  (jetty-launcher-12193-thread-2) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@518eb675[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1392891 WARN  (jetty-launcher-12193-thread-2) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@518eb675[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1392893 WARN  (jetty-launcher-12193-thread-2) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@11cffc7c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1392893 WARN  (jetty-launcher-12193-thread-2) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@11cffc7c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1392895 INFO  (jetty-launcher-12193-thread-2) [     ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34619/solr
   [junit4]   2> 1392895 INFO  (OverseerStateUpdate-73105442280636422-127.0.0.1:38073_solr-n_0000000000) [n:127.0.0.1:38073_solr     ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:38073_solr
   [junit4]   2> 1392895 INFO  (jetty-launcher-12193-thread-1) [n:127.0.0.1:38073_solr     ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38073_solr
   [junit4]   2> 1392895 INFO  (jetty-launcher-12193-thread-2) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1392896 INFO  (OverseerStateUpdate-73105442280636422-127.0.0.1:38073_solr-n_0000000000) [n:127.0.0.1:38073_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1392896 INFO  (zkConnectionManagerCallback-12227-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1392896 INFO  (jetty-launcher-12193-thread-2) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1392899 WARN  (jetty-launcher-12193-thread-2-SendThread(127.0.0.1:34619)) [     ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x103b9032e490007.
   [junit4]   2>           => EndOfStreamException: Unable to read additional data from server sessionid 0x103b9032e490007, 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 0x103b9032e490007, 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> 1392902 INFO  (jetty-launcher-12193-thread-1) [n:127.0.0.1:38073_solr     ] o.a.s.p.PackageLoader /packages.json updated to version -1
   [junit4]   2> 1392903 WARN  (jetty-launcher-12193-thread-1) [n:127.0.0.1:38073_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> 1392924 INFO  (jetty-launcher-12193-thread-1) [n:127.0.0.1:38073_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_BF30E7EEE99EC3B2-001/tempDir-001/node1
   [junit4]   2> 1393000 INFO  (jetty-launcher-12193-thread-2) [n:127.0.0.1:46221_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1393001 INFO  (zkConnectionManagerCallback-12233-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1393001 INFO  (jetty-launcher-12193-thread-2) [n:127.0.0.1:46221_solr     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1393006 INFO  (jetty-launcher-12193-thread-2) [n:127.0.0.1:46221_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1393009 INFO  (jetty-launcher-12193-thread-2) [n:127.0.0.1:46221_solr     ] o.a.s.c.ZkController Publish node=127.0.0.1:46221_solr as DOWN
   [junit4]   2> 1393010 INFO  (jetty-launcher-12193-thread-2) [n:127.0.0.1:46221_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 1393010 INFO  (jetty-launcher-12193-thread-2) [n:127.0.0.1:46221_solr     ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:46221_solr
   [junit4]   2> 1393011 INFO  (zkCallback-12212-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1393011 INFO  (zkCallback-12232-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1393013 INFO  (jetty-launcher-12193-thread-2) [n:127.0.0.1:46221_solr     ] o.a.s.p.PackageLoader /packages.json updated to version -1
   [junit4]   2> 1393013 WARN  (jetty-launcher-12193-thread-2) [n:127.0.0.1:46221_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> 1393023 INFO  (jetty-launcher-12193-thread-2) [n:127.0.0.1:46221_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_BF30E7EEE99EC3B2-001/tempDir-001/node2
   [junit4]   2> 1393030 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
   [junit4]   2> 1393030 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1393031 INFO  (zkConnectionManagerCallback-12244-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1393031 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1393033 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 1393033 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34619/solr ready
   [junit4]   2> 1393041 INFO  (OverseerThreadFactory-12228-thread-1-processing-n:127.0.0.1:38073_solr) [n:127.0.0.1:38073_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection dv_coll
   [junit4]   2> 1393149 INFO  (OverseerStateUpdate-73105442280636422-127.0.0.1:38073_solr-n_0000000000) [n:127.0.0.1:38073_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"dv_coll_shard1_replica_n1",
   [junit4]   2>   "node_name":"127.0.0.1:38073_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:38073/solr",
   [junit4]   2>   "collection":"dv_coll",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1393151 INFO  (OverseerStateUpdate-73105442280636422-127.0.0.1:38073_solr-n_0000000000) [n:127.0.0.1:38073_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"dv_coll_shard2_replica_n2",
   [junit4]   2>   "node_name":"127.0.0.1:46221_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:46221/solr",
   [junit4]   2>   "collection":"dv_coll",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1393157 INFO  (OverseerStateUpdate-73105442280636422-127.0.0.1:38073_solr-n_0000000000) [n:127.0.0.1:38073_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"dv_coll_shard3_replica_n4",
   [junit4]   2>   "node_name":"127.0.0.1:38073_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:38073/solr",
   [junit4]   2>   "collection":"dv_coll",
   [junit4]   2>   "shard":"shard3",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1393165 INFO  (OverseerStateUpdate-73105442280636422-127.0.0.1:38073_solr-n_0000000000) [n:127.0.0.1:38073_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"dv_coll_shard4_replica_n6",
   [junit4]   2>   "node_name":"127.0.0.1:46221_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:46221/solr",
   [junit4]   2>   "collection":"dv_coll",
   [junit4]   2>   "shard":"shard4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1393369 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr    x:dv_coll_shard2_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf1&newCollection=true&name=dv_coll_shard2_replica_n2&action=CREATE&numShards=4&collection=dv_coll&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1393370 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr    x:dv_coll_shard4_replica_n6 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf1&newCollection=true&name=dv_coll_shard4_replica_n6&action=CREATE&numShards=4&collection=dv_coll&shard=shard4&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1393370 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr    x:dv_coll_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf1&newCollection=true&name=dv_coll_shard1_replica_n1&action=CREATE&numShards=4&collection=dv_coll&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1393371 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr    x:dv_coll_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 1393372 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr    x:dv_coll_shard3_replica_n4 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf1&newCollection=true&name=dv_coll_shard3_replica_n4&action=CREATE&numShards=4&collection=dv_coll&shard=shard3&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1393390 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
   [junit4]   2> 1393390 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
   [junit4]   2> 1393392 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
   [junit4]   2> 1393405 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
   [junit4]   2> 1393409 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 1393410 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 1393410 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1393410 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.c.CoreContainer Creating SolrCore 'dv_coll_shard2_replica_n2' using configuration from configset conf1, trusted=true
   [junit4]   2> 1393411 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1393411 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.c.CoreContainer Creating SolrCore 'dv_coll_shard4_replica_n6' using configuration from configset conf1, trusted=true
   [junit4]   2> 1393411 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.c.SolrCore [[dv_coll_shard2_replica_n2] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_BF30E7EEE99EC3B2-001/tempDir-001/node2/dv_coll_shard2_replica_n2], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_BF30E7EEE99EC3B2-001/tempDir-001/node2/dv_coll_shard2_replica_n2/data/]
   [junit4]   2> 1393411 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.c.SolrCore [[dv_coll_shard4_replica_n6] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_BF30E7EEE99EC3B2-001/tempDir-001/node2/dv_coll_shard4_replica_n6], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_BF30E7EEE99EC3B2-001/tempDir-001/node2/dv_coll_shard4_replica_n6/data/]
   [junit4]   2> 1393412 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 1393412 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 1393413 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1393413 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1393413 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'dv_coll_shard1_replica_n1' using configuration from configset conf1, trusted=true
   [junit4]   2> 1393413 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.c.CoreContainer Creating SolrCore 'dv_coll_shard3_replica_n4' using configuration from configset conf1, trusted=true
   [junit4]   2> 1393413 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.c.SolrCore [[dv_coll_shard3_replica_n4] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_BF30E7EEE99EC3B2-001/tempDir-001/node1/dv_coll_shard3_replica_n4], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_BF30E7EEE99EC3B2-001/tempDir-001/node1/dv_coll_shard3_replica_n4/data/]
   [junit4]   2> 1393415 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.c.SolrCore [[dv_coll_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_BF30E7EEE99EC3B2-001/tempDir-001/node1/dv_coll_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_BF30E7EEE99EC3B2-001/tempDir-001/node1/dv_coll_shard1_replica_n1/data/]
   [junit4]   2> 1393447 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1393447 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1393447 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1393447 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1393448 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1393448 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1393448 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1393448 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1393448 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1393448 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1393448 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1393448 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1393449 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1393449 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1393449 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1393449 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1393450 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 1393450 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 1393450 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 1393450 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 1393450 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1393450 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/conf1/managed-schema
   [junit4]   2> 1393450 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1393450 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/conf1/managed-schema
   [junit4]   2> 1393451 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1393451 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/conf1/managed-schema
   [junit4]   2> 1393451 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1393451 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/conf1/managed-schema
   [junit4]   2> 1393451 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 1393451 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1393451 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1693390160079618048
   [junit4]   2> 1393451 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 1393451 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1393451 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1693390160079618048
   [junit4]   2> 1393452 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 1393452 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1393452 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1693390160080666624
   [junit4]   2> 1393453 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 1393453 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1393453 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1693390160081715200
   [junit4]   2> 1393453 INFO  (searcherExecutor-12246-thread-1-processing-n:127.0.0.1:46221_solr x:dv_coll_shard2_replica_n2 c:dv_coll s:shard2 r:core_node5) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.c.SolrCore [dv_coll_shard2_replica_n2]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1393454 INFO  (searcherExecutor-12251-thread-1-processing-n:127.0.0.1:38073_solr x:dv_coll_shard1_replica_n1 c:dv_coll s:shard1 r:core_node3) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.c.SolrCore [dv_coll_shard1_replica_n1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1393455 INFO  (searcherExecutor-12252-thread-1-processing-n:127.0.0.1:38073_solr x:dv_coll_shard3_replica_n4 c:dv_coll s:shard3 r:core_node7) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.c.SolrCore [dv_coll_shard3_replica_n4]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1393456 INFO  (searcherExecutor-12248-thread-1-processing-n:127.0.0.1:46221_solr x:dv_coll_shard4_replica_n6 c:dv_coll s:shard4 r:core_node8) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.c.SolrCore [dv_coll_shard4_replica_n6]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1393460 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/dv_coll/terms/shard2 to Terms{values={core_node5=0}, version=0}
   [junit4]   2> 1393460 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/dv_coll/leaders/shard2
   [junit4]   2> 1393461 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/dv_coll/terms/shard3 to Terms{values={core_node7=0}, version=0}
   [junit4]   2> 1393463 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/dv_coll/terms/shard4 to Terms{values={core_node8=0}, version=0}
   [junit4]   2> 1393463 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/dv_coll/leaders/shard4
   [junit4]   2> 1393464 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/dv_coll/terms/shard1 to Terms{values={core_node3=0}, version=0}
   [junit4]   2> 1393464 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/dv_coll/leaders/shard1
   [junit4]   2> 1393464 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/dv_coll/leaders/shard3
   [junit4]   2> 1393466 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1393466 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1393466 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:46221/solr/dv_coll_shard2_replica_n2/
   [junit4]   2> 1393467 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1393468 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.c.SyncStrategy http://127.0.0.1:46221/solr/dv_coll_shard2_replica_n2/ has no replicas
   [junit4]   2> 1393468 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/dv_coll/leaders/shard2/leader after winning as /collections/dv_coll/leader_elect/shard2/election/73105442280636424-core_node5-n_0000000000
   [junit4]   2> 1393468 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1393468 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1393468 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:38073/solr/dv_coll_shard1_replica_n1/
   [junit4]   2> 1393469 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1393469 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1393469 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:38073/solr/dv_coll_shard3_replica_n4/
   [junit4]   2> 1393470 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1393470 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1393471 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.c.SyncStrategy http://127.0.0.1:38073/solr/dv_coll_shard3_replica_n4/ has no replicas
   [junit4]   2> 1393471 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/dv_coll/leaders/shard3/leader after winning as /collections/dv_coll/leader_elect/shard3/election/73105442280636422-core_node7-n_0000000000
   [junit4]   2> 1393471 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:46221/solr/dv_coll_shard2_replica_n2/ shard2
   [junit4]   2> 1393471 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1393471 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1393471 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:46221/solr/dv_coll_shard4_replica_n6/
   [junit4]   2> 1393472 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.c.SyncStrategy http://127.0.0.1:38073/solr/dv_coll_shard1_replica_n1/ has no replicas
   [junit4]   2> 1393472 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/dv_coll/leaders/shard1/leader after winning as /collections/dv_coll/leader_elect/shard1/election/73105442280636422-core_node3-n_0000000000
   [junit4]   2> 1393472 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1393473 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.c.SyncStrategy http://127.0.0.1:46221/solr/dv_coll_shard4_replica_n6/ has no replicas
   [junit4]   2> 1393473 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/dv_coll/leaders/shard4/leader after winning as /collections/dv_coll/leader_elect/shard4/election/73105442280636424-core_node8-n_0000000000
   [junit4]   2> 1393474 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:46221/solr/dv_coll_shard4_replica_n6/ shard4
   [junit4]   2> 1393475 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:38073/solr/dv_coll_shard1_replica_n1/ shard1
   [junit4]   2> 1393476 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:38073/solr/dv_coll_shard3_replica_n4/ shard3
   [junit4]   2> 1393578 INFO  (zkCallback-12212-thread-1) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1393578 INFO  (zkCallback-12212-thread-2) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1393578 INFO  (zkCallback-12212-thread-3) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1393582 INFO  (zkCallback-12232-thread-1) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1393582 INFO  (zkCallback-12232-thread-2) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1393583 INFO  (zkCallback-12232-thread-4) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1393583 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1393583 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1393586 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1393586 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1393590 INFO  (qtp1978882073-18055) [n:127.0.0.1:38073_solr     ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf1&newCollection=true&name=dv_coll_shard1_replica_n1&action=CREATE&numShards=4&collection=dv_coll&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=219
   [junit4]   2> 1393591 INFO  (qtp1978882073-18057) [n:127.0.0.1:38073_solr     ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf1&newCollection=true&name=dv_coll_shard3_replica_n4&action=CREATE&numShards=4&collection=dv_coll&shard=shard3&wt=javabin&version=2&replicaType=NRT} status=0 QTime=219
   [junit4]   2> 1393592 INFO  (qtp577288902-18049) [n:127.0.0.1:46221_solr     ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf1&newCollection=true&name=dv_coll_shard2_replica_n2&action=CREATE&numShards=4&collection=dv_coll&shard=shard2&wt=javabin&version=2&replicaType=NRT} status=0 QTime=222
   [junit4]   2> 1393598 INFO  (qtp577288902-18045) [n:127.0.0.1:46221_solr     ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf1&newCollection=true&name=dv_coll_shard4_replica_n6&action=CREATE&numShards=4&collection=dv_coll&shard=shard4&wt=javabin&version=2&replicaType=NRT} status=0 QTime=228
   [junit4]   2> 1393600 INFO  (qtp577288902-18047) [n:127.0.0.1:46221_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> 1393690 INFO  (zkCallback-12212-thread-2) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1393690 INFO  (zkCallback-12212-thread-3) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1393690 INFO  (zkCallback-12212-thread-1) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1393690 INFO  (zkCallback-12232-thread-4) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1393691 INFO  (zkCallback-12232-thread-2) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1393691 INFO  (zkCallback-12232-thread-3) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1393691 INFO  (zkCallback-12232-thread-5) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1393691 INFO  (zkCallback-12212-thread-4) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEv

[...truncated too long message...]

 2> 1394683 INFO  (jetty-closer-12283-thread-2) [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1394684 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
   [junit4]   2> 1394685 WARN  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker-SendThread(127.0.0.1:34619)) [     ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x103b9032e490000.
   [junit4]   2>           => EndOfStreamException: Unable to read additional data from server sessionid 0x103b9032e490000, 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 0x103b9032e490000, 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> 1394786 WARN  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker-SendThread(127.0.0.1:34619)) [     ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x103b9032e490001.
   [junit4]   2>           => EndOfStreamException: Unable to read additional data from server sessionid 0x103b9032e490001, 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 0x103b9032e490001, 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> 1394887 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> 	6	/solr/configs/conf1/managed-schema
   [junit4]   2> 	4	/solr/configs/conf1
   [junit4]   2> 	3	/solr/clusterprops.json
   [junit4]   2> 	3	/solr/aliases.json
   [junit4]   2> 	3	/solr/collections/dv_coll/terms/shard3
   [junit4]   2> 	3	/solr/collections/dv_coll/terms/shard2
   [junit4]   2> 	3	/solr/collections/dv_coll/terms/shard1
   [junit4]   2> 	3	/solr/collections/dv_coll/terms/shard4
   [junit4]   2> 	2	/solr/packages.json
   [junit4]   2> 	2	/solr/security.json
   [junit4]   2> 	2	/solr/collections/dv_coll/collectionprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2> 	25	/solr/collections/dv_coll/state.json
   [junit4]   2> 	4	/solr/configs/conf1/managed-schema
   [junit4]   2> 	3	/solr/clusterstate.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2> 	22	/solr/overseer/queue
   [junit4]   2> 	11	/solr/collections/dv_coll/state.json
   [junit4]   2> 	7	/solr/live_nodes
   [junit4]   2> 	6	/solr/collections
   [junit4]   2> 	5	/solr/overseer/collection-queue-work
   [junit4]   2> 
   [junit4]   2> 1394890 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:34619
   [junit4]   2> 1394890 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:34619
   [junit4]   2> 1394890 INFO  (SUITE-DocValuesNotIndexedTest-seed#[BF30E7EEE99EC3B2]-worker) [     ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 34619
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_BF30E7EEE99EC3B2-001
   [junit4]   2> Mar 05, 2021 11:11:44 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): {_root_=Lucene84, id=PostingsFormat(name=Direct)}, docValues:{floatField=DocValuesFormat(name=Asserting), doubleField=DocValuesFormat(name=Direct), intFieldMulti=DocValuesFormat(name=Asserting), sortableGSL=DocValuesFormat(name=Lucene80), boolFieldMulti=DocValuesFormat(name=Direct), floatGSL=DocValuesFormat(name=Lucene80), longFieldMulti=DocValuesFormat(name=Lucene80), sortableGSF=DocValuesFormat(name=Asserting), intField=DocValuesFormat(name=Direct), boolField=DocValuesFormat(name=Lucene80), sortableFieldMulti=DocValuesFormat(name=Lucene80), stringFieldMulti=DocValuesFormat(name=Lucene80), dateFieldMulti=DocValuesFormat(name=Lucene80), longGSF=DocValuesFormat(name=Asserting), doubleFieldMulti=DocValuesFormat(name=Lucene80), stringGSL=DocValuesFormat(name=Lucene80), doubleGSF=DocValuesFormat(name=Direct), doubleGSL=DocValuesFormat(name=Lucene80), stringGSF=DocValuesFormat(name=Direct), intGSL=DocValuesFormat(name=Direct), sortableText=DocValuesFormat(name=Lucene80), longField=DocValuesFormat(name=Asserting), dateField=DocValuesFormat(name=Lucene80), dateGSF=DocValuesFormat(name=Lucene80), boolGSF=DocValuesFormat(name=Lucene80), longGSL=DocValuesFormat(name=Lucene80), boolGSL=DocValuesFormat(name=Asserting), floatFieldMulti=DocValuesFormat(name=Direct), floatGSF=DocValuesFormat(name=Asserting), dateGSL=DocValuesFormat(name=Asserting), intGSF=DocValuesFormat(name=Lucene80), stringField=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=568, maxMBSortInHeap=5.282445354691649, sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=ms, timezone=Africa/Mogadishu
   [junit4]   2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation 1.8.0_281 (64-bit)/cpus=4,threads=1,free=194956392,total=518520832
   [junit4]   2> NOTE: All tests run in this JVM: [TestTextField, TestCustomStream, TestConfigSetsAPIShareSchema, TestStressThreadBackup, SplitByPrefixTest, TestTolerantUpdateProcessorCloud, ZkStateReaderTest, CollectionTooManyReplicasTest, SpatialFilterTest, TestFieldCache, TestSimClusterStateProvider, BackupIdTest, CoreMergeIndexesAdminHandlerTest, TestNestedUpdateProcessor, CustomHighlightComponentTest, SignatureUpdateProcessorFactoryTest, TestJettySolrRunner, DistributedExpandComponentTest, TestSimpleTrackingShardHandler, TestLocalFSCloudBackupRestore, TestCloudPivotFacet, TestRestManager, UnloadDistributedZkTest, TestReqParamsAPI, AuditLoggerIntegrationTest, PeerSyncWithLeaderAndIndexFingerprintCachingTest, SplitShardTest, AnalyticsMergeStrategyTest, TestFoldingMultitermQuery, OverseerTest, HLLUtilTest, MetricsHistoryIntegrationTest, InfoHandlerTest, AutoAddReplicasPlanActionTest, TestCollapseQParserPlugin, TestNoOpRegenerator, SearchRateTriggerIntegrationTest, TestSchemaField, JavabinLoaderTest, PingRequestHandlerTest, DateFieldTest, DistributedUpdateProcessorTest, TestExportTool, LeaderFailureAfterFreshStartTest, DistributedQueryComponentCustomSortTest, HdfsWriteToMultipleCollectionsTest, CoreAdminCreateDiscoverTest, CollectionStateFormat2Test, TestSimTriggerIntegration, TestManagedSynonymFilterFactory, CdcrRequestHandlerTest, HighlighterConfigTest, TestStandardQParsers, DistributedSuggestComponentTest, SolrMetricsIntegrationTest, HdfsNNFailoverTest, TestConfig, TestBinaryField, TestConfigSets, IndexSizeTriggerTest, DeleteNodeTest, TestRemoteStreaming, TestConfigsApi, TestSchemaVersionResource, TestTrieFacet, AtomicUpdatesTest, MaxSizeAutoCommitTest, TestDocBasedVersionConstraints, RestoreTriggerStateTest, TermVectorComponentTest, UpdateRequestProcessorFactoryTest, TestCloudSearcherWarming, TestSimpleTextCodec, TestAtomicUpdateErrorCases, SimpleMLTQParserTest, CdcrUpdateLogTest, JWTVerificationkeyResolverTest, CdcrBidirectionalTest, TestCustomSort, BooleanFieldTest, RequestHandlersTest, TestLockTree, TestCloudJSONFacetSKG, GraphQueryTest, UtilsToolTest, AliasIntegrationTest, TestScoreJoinQPScore, TestSolr4Spatial, TestStressUserVersions, RouteFieldTest, TestLuceneMatchVersion, TestGraphMLResponseWriter, NodeAddedTriggerTest, SegmentsInfoRequestHandlerTest, XmlUpdateRequestHandlerTest, ZkFailoverTest, DOMUtilTest, TestInitQParser, ChaosMonkeySafeLeaderWithPullReplicasTest, MoreLikeThisComponentTest, SuggesterWFSTTest, LocalFSCloudIncrementalBackupTest, TestFieldTypeResource, ClassificationUpdateProcessorTest, TestDistribDocBasedVersion, MetricsDisabledCloudTest, AggValueSourceTest, TestNumericTerms64, DocValuesTest, TestCollationField, TestSnapshotCoreBackup, DistributedFacetSimpleRefinementLongTailTest, TestNumericTokenStream, CacheHeaderTest, AnalysisAfterCoreReloadTest, BasicFunctionalityTest, ConvertedLegacyTest, CursorPagingTest, DisMaxRequestHandlerTest, DistributedIntervalFacetingTest, EchoParamsTest, MinimalSchemaTest, OutputWriterTest, SampleTest, SolrInfoBeanTest, SolrTestCaseJ4DeleteCoreTest, SolrTestCaseJ4Test, TestCrossCoreJoin, TestCursorMarkWithoutUniqueKey, TestDistributedGrouping, TestDistributedMissingSort, TestDistributedSearch, TestJoin, PathHierarchyTokenizerFactoryTest, ProtectedTermFilterFactoryTest, TestWordDelimiterFilterFactory, TokenizerChainTest, TestLuceneIndexBackCompat, ClusterStateMockUtilTest, ClusterStateTest, ConcurrentCreateRoutedAliasTest, ConnectionManagerTest, CreateRoutedAliasTest, DocValuesNotIndexedTest]
   [junit4] Completed [513/934 (1!)] on J0 in 3.77s, 5 tests, 1 failure <<< FAILURES!

[...truncated 52158 lines...]

[JENKINS] Lucene » Lucene-Solr-BadApples-Tests-8.x - Build # 206 - Still Failing!

Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-BadApples-Tests-8.x/206/

All tests passed

Build Log:
[...truncated 67177 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:643: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:507: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:494: Source checkout is dirty (unversioned/missing files) after running tests!!! Offending files:
* solr/contrib/analytics/src/test-files/solr/filestore
* solr/contrib/analytics/src/test-files/solr/userfiles
* solr/contrib/dataimporthandler-extras/src/test-files/dihextras/solr/collection1/conf/dataimport.properties
* solr/contrib/dataimporthandler-extras/src/test-files/dihextras/solr/filestore
* solr/contrib/dataimporthandler-extras/src/test-files/dihextras/solr/userfiles
* solr/contrib/dataimporthandler/src/test-files/dih/solr/filestore
* solr/contrib/dataimporthandler/src/test-files/dih/solr/userfiles
* solr/contrib/extraction/src/test-files/extraction/solr/filestore
* solr/contrib/extraction/src/test-files/extraction/solr/userfiles
* solr/contrib/langid/src/test-files/langid/solr/filestore
* solr/contrib/langid/src/test-files/langid/solr/userfiles
* solr/contrib/ltr/src/test-files/solr/filestore
* solr/contrib/ltr/src/test-files/solr/userfiles
* solr/contrib/prometheus-exporter/src/test-files/solr/filestore
* solr/contrib/prometheus-exporter/src/test-files/solr/userfiles
* solr/contrib/velocity/src/test-files/velocity/solr/filestore
* solr/contrib/velocity/src/test-files/velocity/solr/userfiles
* solr/core/src/test-files/solr/filestore
* solr/core/src/test-files/solr/userfiles
* solr/solrj/src/test-files/solrj/solr/multicore/filestore
* solr/solrj/src/test-files/solrj/solr/multicore/userfiles

Total time: 71 minutes 27 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any

[JENKINS] Lucene » Lucene-Solr-BadApples-Tests-8.x - Build # 205 - Still Failing!

Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-BadApples-Tests-8.x/205/

All tests passed

Build Log:
[...truncated 67158 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:643: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:507: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:494: Source checkout is dirty (unversioned/missing files) after running tests!!! Offending files:
* solr/contrib/analytics/src/test-files/solr/filestore
* solr/contrib/analytics/src/test-files/solr/userfiles
* solr/contrib/dataimporthandler-extras/src/test-files/dihextras/solr/collection1/conf/dataimport.properties
* solr/contrib/dataimporthandler-extras/src/test-files/dihextras/solr/filestore
* solr/contrib/dataimporthandler-extras/src/test-files/dihextras/solr/userfiles
* solr/contrib/dataimporthandler/src/test-files/dih/solr/filestore
* solr/contrib/dataimporthandler/src/test-files/dih/solr/userfiles
* solr/contrib/extraction/src/test-files/extraction/solr/filestore
* solr/contrib/extraction/src/test-files/extraction/solr/userfiles
* solr/contrib/langid/src/test-files/langid/solr/filestore
* solr/contrib/langid/src/test-files/langid/solr/userfiles
* solr/contrib/ltr/src/test-files/solr/filestore
* solr/contrib/ltr/src/test-files/solr/userfiles
* solr/contrib/prometheus-exporter/src/test-files/solr/filestore
* solr/contrib/prometheus-exporter/src/test-files/solr/userfiles
* solr/contrib/velocity/src/test-files/velocity/solr/filestore
* solr/contrib/velocity/src/test-files/velocity/solr/userfiles
* solr/core/src/test-files/solr/filestore
* solr/core/src/test-files/solr/userfiles
* solr/solrj/src/test-files/solrj/solr/multicore/filestore
* solr/solrj/src/test-files/solrj/solr/multicore/userfiles

Total time: 71 minutes 19 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any

[JENKINS] Lucene » Lucene-Solr-BadApples-Tests-8.x - Build # 204 - Still Failing!

Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-BadApples-Tests-8.x/204/

All tests passed

Build Log:
[...truncated 67139 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:643: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:507: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:494: Source checkout is dirty (unversioned/missing files) after running tests!!! Offending files:
* solr/contrib/analytics/src/test-files/solr/filestore
* solr/contrib/analytics/src/test-files/solr/userfiles
* solr/contrib/dataimporthandler-extras/src/test-files/dihextras/solr/collection1/conf/dataimport.properties
* solr/contrib/dataimporthandler-extras/src/test-files/dihextras/solr/filestore
* solr/contrib/dataimporthandler-extras/src/test-files/dihextras/solr/userfiles
* solr/contrib/dataimporthandler/src/test-files/dih/solr/filestore
* solr/contrib/dataimporthandler/src/test-files/dih/solr/userfiles
* solr/contrib/extraction/src/test-files/extraction/solr/filestore
* solr/contrib/extraction/src/test-files/extraction/solr/userfiles
* solr/contrib/langid/src/test-files/langid/solr/filestore
* solr/contrib/langid/src/test-files/langid/solr/userfiles
* solr/contrib/ltr/src/test-files/solr/filestore
* solr/contrib/ltr/src/test-files/solr/userfiles
* solr/contrib/prometheus-exporter/src/test-files/solr/filestore
* solr/contrib/prometheus-exporter/src/test-files/solr/userfiles
* solr/contrib/velocity/src/test-files/velocity/solr/filestore
* solr/contrib/velocity/src/test-files/velocity/solr/userfiles
* solr/core/src/test-files/solr/filestore
* solr/core/src/test-files/solr/userfiles
* solr/solrj/src/test-files/solrj/solr/multicore/filestore
* solr/solrj/src/test-files/solrj/solr/multicore/userfiles

Total time: 73 minutes 9 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any

[JENKINS] Lucene » Lucene-Solr-BadApples-Tests-8.x - Build # 203 - Still Failing!

Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-BadApples-Tests-8.x/203/

All tests passed

Build Log:
[...truncated 67183 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:643: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:507: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/build.xml:494: Source checkout is dirty (unversioned/missing files) after running tests!!! Offending files:
* solr/contrib/analytics/src/test-files/solr/filestore
* solr/contrib/analytics/src/test-files/solr/userfiles
* solr/contrib/dataimporthandler-extras/src/test-files/dihextras/solr/collection1/conf/dataimport.properties
* solr/contrib/dataimporthandler-extras/src/test-files/dihextras/solr/filestore
* solr/contrib/dataimporthandler-extras/src/test-files/dihextras/solr/userfiles
* solr/contrib/dataimporthandler/src/test-files/dih/solr/filestore
* solr/contrib/dataimporthandler/src/test-files/dih/solr/userfiles
* solr/contrib/extraction/src/test-files/extraction/solr/filestore
* solr/contrib/extraction/src/test-files/extraction/solr/userfiles
* solr/contrib/langid/src/test-files/langid/solr/filestore
* solr/contrib/langid/src/test-files/langid/solr/userfiles
* solr/contrib/ltr/src/test-files/solr/filestore
* solr/contrib/ltr/src/test-files/solr/userfiles
* solr/contrib/prometheus-exporter/src/test-files/solr/filestore
* solr/contrib/prometheus-exporter/src/test-files/solr/userfiles
* solr/contrib/velocity/src/test-files/velocity/solr/filestore
* solr/contrib/velocity/src/test-files/velocity/solr/userfiles
* solr/core/src/test-files/solr/filestore
* solr/core/src/test-files/solr/userfiles
* solr/solrj/src/test-files/solrj/solr/multicore/filestore
* solr/solrj/src/test-files/solrj/solr/multicore/userfiles

Total time: 74 minutes 23 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any