Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Windows/305/
Java: 64bit/jdk-13-ea+18 -XX:+UseCompressedOops -XX:+UseG1GC

No tests ran.

Build Log:
[...truncated 14689 lines...]
   [junit4] Suite: org.apache.solr.cloud.MissingSegmentRecoveryTest
   [junit4]   2> Creating dataDir: 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.MissingSegmentRecoveryTest_B4301A40F3DF8372-001\init-core-data-001
   [junit4]   2> 2700515 INFO  
(SUITE-MissingSegmentRecoveryTest-seed#[B4301A40F3DF8372]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 2700517 INFO  
(SUITE-MissingSegmentRecoveryTest-seed#[B4301A40F3DF8372]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 2700517 INFO  
(SUITE-MissingSegmentRecoveryTest-seed#[B4301A40F3DF8372]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 2700518 INFO  
(SUITE-MissingSegmentRecoveryTest-seed#[B4301A40F3DF8372]-worker) [     ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.MissingSegmentRecoveryTest_B4301A40F3DF8372-001\tempDir-001
   [junit4]   2> 2700518 INFO  
(SUITE-MissingSegmentRecoveryTest-seed#[B4301A40F3DF8372]-worker) [     ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2700522 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2700522 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 2700619 INFO  
(SUITE-MissingSegmentRecoveryTest-seed#[B4301A40F3DF8372]-worker) [     ] 
o.a.s.c.ZkTestServer start zk server on port:50585
   [junit4]   2> 2700619 INFO  
(SUITE-MissingSegmentRecoveryTest-seed#[B4301A40F3DF8372]-worker) [     ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:50585
   [junit4]   2> 2700619 INFO  
(SUITE-MissingSegmentRecoveryTest-seed#[B4301A40F3DF8372]-worker) [     ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 50585
   [junit4]   2> 2700624 INFO  
(SUITE-MissingSegmentRecoveryTest-seed#[B4301A40F3DF8372]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2700637 INFO  (zkConnectionManagerCallback-17931-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2700637 INFO  
(SUITE-MissingSegmentRecoveryTest-seed#[B4301A40F3DF8372]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2700642 INFO  
(SUITE-MissingSegmentRecoveryTest-seed#[B4301A40F3DF8372]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2700646 INFO  (zkConnectionManagerCallback-17933-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2700646 INFO  
(SUITE-MissingSegmentRecoveryTest-seed#[B4301A40F3DF8372]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2700648 INFO  
(SUITE-MissingSegmentRecoveryTest-seed#[B4301A40F3DF8372]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2700652 INFO  (zkConnectionManagerCallback-17935-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2700652 INFO  
(SUITE-MissingSegmentRecoveryTest-seed#[B4301A40F3DF8372]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2700757 WARN  (jetty-launcher-17936-thread-2) [     ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 2700757 WARN  (jetty-launcher-17936-thread-1) [     ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 2700758 INFO  (jetty-launcher-17936-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 2700758 INFO  (jetty-launcher-17936-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 2700758 INFO  (jetty-launcher-17936-thread-2) [     ] 
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: 
c4550056e785fb5665914545889f21dc136ad9e6; jvm 13-ea+18
   [junit4]   2> 2700758 INFO  (jetty-launcher-17936-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 2700758 INFO  (jetty-launcher-17936-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 2700758 INFO  (jetty-launcher-17936-thread-1) [     ] 
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: 
c4550056e785fb5665914545889f21dc136ad9e6; jvm 13-ea+18
   [junit4]   2> 2700759 INFO  (jetty-launcher-17936-thread-2) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2700759 INFO  (jetty-launcher-17936-thread-2) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2700759 INFO  (jetty-launcher-17936-thread-2) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 2700759 INFO  (jetty-launcher-17936-thread-1) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2700759 INFO  (jetty-launcher-17936-thread-1) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2700759 INFO  (jetty-launcher-17936-thread-2) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@5711979{/solr,null,AVAILABLE}
   [junit4]   2> 2700759 INFO  (jetty-launcher-17936-thread-1) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 2700760 INFO  (jetty-launcher-17936-thread-1) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@75edd4c2{/solr,null,AVAILABLE}
   [junit4]   2> 2700762 INFO  (jetty-launcher-17936-thread-2) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@723175b6{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:50598}
   [junit4]   2> 2700762 INFO  (jetty-launcher-17936-thread-2) [     ] 
o.e.j.s.Server Started @2700796ms
   [junit4]   2> 2700762 INFO  (jetty-launcher-17936-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=50598}
   [junit4]   2> 2700762 ERROR (jetty-launcher-17936-thread-2) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2700762 INFO  (jetty-launcher-17936-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2700762 INFO  (jetty-launcher-17936-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.2.0
   [junit4]   2> 2700762 INFO  (jetty-launcher-17936-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2700762 INFO  (jetty-launcher-17936-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2700762 INFO  (jetty-launcher-17936-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-06-12T23:32:18.562561Z
   [junit4]   2> 2700762 INFO  (jetty-launcher-17936-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2700766 INFO  (jetty-launcher-17936-thread-1) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@4d5ddb6b{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:50601}
   [junit4]   2> 2700766 INFO  (jetty-launcher-17936-thread-1) [     ] 
o.e.j.s.Server Started @2700799ms
   [junit4]   2> 2700766 INFO  (jetty-launcher-17936-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=50601}
   [junit4]   2> 2700766 ERROR (jetty-launcher-17936-thread-1) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2700766 INFO  (jetty-launcher-17936-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2700766 INFO  (jetty-launcher-17936-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.2.0
   [junit4]   2> 2700766 INFO  (jetty-launcher-17936-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2700766 INFO  (jetty-launcher-17936-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2700766 INFO  (jetty-launcher-17936-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-06-12T23:32:18.566031600Z
   [junit4]   2> 2700768 INFO  (jetty-launcher-17936-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2700769 INFO  (zkConnectionManagerCallback-17938-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2700769 INFO  (jetty-launcher-17936-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2700770 INFO  (jetty-launcher-17936-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2700773 INFO  (zkConnectionManagerCallback-17940-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2700773 INFO  (jetty-launcher-17936-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2700773 INFO  (jetty-launcher-17936-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2701108 INFO  (jetty-launcher-17936-thread-2) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 2701111 WARN  (jetty-launcher-17936-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@466ff33b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2701122 WARN  (jetty-launcher-17936-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@5d0784b5[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2701123 INFO  (jetty-launcher-17936-thread-2) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50585/solr
   [junit4]   2> 2701125 INFO  (jetty-launcher-17936-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2701143 INFO  (zkConnectionManagerCallback-17948-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2701143 INFO  (jetty-launcher-17936-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2701149 INFO  (jetty-launcher-17936-thread-1) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 2701149 WARN  (jetty-launcher-17936-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@13fe0708[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2701154 WARN  (jetty-launcher-17936-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@3bf12650[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2701154 INFO  (jetty-launcher-17936-thread-1) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50585/solr
   [junit4]   2> 2701158 INFO  (jetty-launcher-17936-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2701169 INFO  (zkConnectionManagerCallback-17954-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2701169 INFO  (jetty-launcher-17936-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2701245 INFO  (jetty-launcher-17936-thread-2) 
[n:127.0.0.1:50598_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 2701252 INFO  (zkConnectionManagerCallback-17956-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2701253 INFO  (jetty-launcher-17936-thread-2) 
[n:127.0.0.1:50598_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 2701346 INFO  (jetty-launcher-17936-thread-1) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 2701369 INFO  (zkConnectionManagerCallback-17960-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2701369 INFO  (jetty-launcher-17936-thread-1) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 2701391 INFO  (jetty-launcher-17936-thread-1) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:50601_solr
   [junit4]   2> 2701393 INFO  (jetty-launcher-17936-thread-1) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.Overseer Overseer 
(id=72063153472733192-127.0.0.1:50601_solr-n_0000000000) starting
   [junit4]   2> 2701400 INFO  (jetty-launcher-17936-thread-1) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 2701406 INFO  (zkConnectionManagerCallback-17967-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2701406 INFO  (jetty-launcher-17936-thread-1) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 2701421 INFO  (jetty-launcher-17936-thread-1) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:50585/solr ready
   [junit4]   2> 2701422 INFO  (jetty-launcher-17936-thread-1) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:50601_solr
   [junit4]   2> 2701423 INFO  
(OverseerStateUpdate-72063153472733192-127.0.0.1:50601_solr-n_0000000000) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:50601_solr
   [junit4]   2> 2701425 INFO  
(OverseerStateUpdate-72063153472733192-127.0.0.1:50601_solr-n_0000000000) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2701438 INFO  (zkCallback-17966-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 2701476 INFO  (jetty-launcher-17936-thread-1) 
[n:127.0.0.1:50601_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 2701490 INFO  (jetty-launcher-17936-thread-2) 
[n:127.0.0.1:50598_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2701498 INFO  (jetty-launcher-17936-thread-2) 
[n:127.0.0.1:50598_solr     ] o.a.s.c.ZkController Publish 
node=127.0.0.1:50598_solr as DOWN
   [junit4]   2> 2701501 INFO  (jetty-launcher-17936-thread-2) 
[n:127.0.0.1:50598_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 2701501 INFO  (jetty-launcher-17936-thread-2) 
[n:127.0.0.1:50598_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:50598_solr
   [junit4]   2> 2701509 INFO  (zkCallback-17959-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2701509 INFO  (zkCallback-17966-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2701516 INFO  (zkCallback-17955-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2701519 INFO  (jetty-launcher-17936-thread-2) 
[n:127.0.0.1:50598_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 2701520 INFO  (jetty-launcher-17936-thread-1) 
[n:127.0.0.1:50601_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_50601.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d22bbf0
   [junit4]   2> 2701523 INFO  (jetty-launcher-17936-thread-1) 
[n:127.0.0.1:50601_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_50601.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d22bbf0
   [junit4]   2> 2701523 INFO  (jetty-launcher-17936-thread-1) 
[n:127.0.0.1:50601_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_50601.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d22bbf0
   [junit4]   2> 2701523 INFO  (jetty-launcher-17936-thread-1) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.MissingSegmentRecoveryTest_B4301A40F3DF8372-001\tempDir-001\node1\.
   [junit4]   2> 2701537 INFO  (zkConnectionManagerCallback-17973-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2701544 INFO  (jetty-launcher-17936-thread-2) 
[n:127.0.0.1:50598_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 2701544 INFO  (jetty-launcher-17936-thread-2) 
[n:127.0.0.1:50598_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 2701548 INFO  (jetty-launcher-17936-thread-2) 
[n:127.0.0.1:50598_solr     ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:50585/solr ready
   [junit4]   2> 2701592 INFO  (jetty-launcher-17936-thread-2) 
[n:127.0.0.1:50598_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 2701618 INFO  (jetty-launcher-17936-thread-2) 
[n:127.0.0.1:50598_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_50598.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d22bbf0
   [junit4]   2> 2701629 INFO  (jetty-launcher-17936-thread-2) 
[n:127.0.0.1:50598_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_50598.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d22bbf0
   [junit4]   2> 2701629 INFO  (jetty-launcher-17936-thread-2) 
[n:127.0.0.1:50598_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_50598.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d22bbf0
   [junit4]   2> 2701632 INFO  (jetty-launcher-17936-thread-2) 
[n:127.0.0.1:50598_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.MissingSegmentRecoveryTest_B4301A40F3DF8372-001\tempDir-001\node2\.
   [junit4]   2> 2701694 INFO  
(SUITE-MissingSegmentRecoveryTest-seed#[B4301A40F3DF8372]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2701700 INFO  (zkConnectionManagerCallback-17979-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2701700 INFO  
(SUITE-MissingSegmentRecoveryTest-seed#[B4301A40F3DF8372]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2701703 INFO  
(SUITE-MissingSegmentRecoveryTest-seed#[B4301A40F3DF8372]-worker) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 2701705 INFO  
(SUITE-MissingSegmentRecoveryTest-seed#[B4301A40F3DF8372]-worker) [     ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:50585/solr ready
   [junit4]   2> 2701734 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.SolrTestCaseJ4 ###Starting testLeaderRecovery
   [junit4]   2> 2701736 INFO  (qtp1824388596-48724) [n:127.0.0.1:50598_solr    
 ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
collection.configName=conf&maxShardsPerNode=1&name=MissingSegmentRecoveryTest&nrtReplicas=2&action=CREATE&numShards=1&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2701742 INFO  
(OverseerThreadFactory-14563-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
MissingSegmentRecoveryTest
   [junit4]   2> 2701859 INFO  
(OverseerStateUpdate-72063153472733192-127.0.0.1:50601_solr-n_0000000000) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"MissingSegmentRecoveryTest",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"MissingSegmentRecoveryTest_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:50598/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2701862 INFO  
(OverseerStateUpdate-72063153472733192-127.0.0.1:50601_solr-n_0000000000) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"MissingSegmentRecoveryTest",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"MissingSegmentRecoveryTest_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:50601/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2702066 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr    
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation 
core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=MissingSegmentRecoveryTest_shard1_replica_n1&action=CREATE&numShards=1&collection=MissingSegmentRecoveryTest&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2702067 INFO  (qtp107073346-48727) [n:127.0.0.1:50601_solr    
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.h.a.CoreAdminOperation 
core create command 
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=MissingSegmentRecoveryTest_shard1_replica_n2&action=CREATE&numShards=1&collection=MissingSegmentRecoveryTest&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2702067 INFO  (qtp107073346-48727) [n:127.0.0.1:50601_solr    
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 2703089 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 8.2.0
   [junit4]   2> 2703090 INFO  (qtp107073346-48727) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 8.2.0
   [junit4]   2> 2703099 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.s.IndexSchema 
[MissingSegmentRecoveryTest_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 2703101 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded 
schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2703101 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating 
SolrCore 'MissingSegmentRecoveryTest_shard1_replica_n1' using configuration 
from collection MissingSegmentRecoveryTest, trusted=true
   [junit4]   2> 2703102 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 
'solr_50598.solr.core.MissingSegmentRecoveryTest.shard1.replica_n1' (registry 
'solr.core.MissingSegmentRecoveryTest.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d22bbf0
   [junit4]   2> 2703102 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.c.SolrCore 
[[MissingSegmentRecoveryTest_shard1_replica_n1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.MissingSegmentRecoveryTest_B4301A40F3DF8372-001\tempDir-001\node2\MissingSegmentRecoveryTest_shard1_replica_n1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.MissingSegmentRecoveryTest_B4301A40F3DF8372-001\tempDir-001\node2\.\MissingSegmentRecoveryTest_shard1_replica_n1\data\]
   [junit4]   2> 2703102 INFO  (qtp107073346-48727) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.s.IndexSchema 
[MissingSegmentRecoveryTest_shard1_replica_n2] Schema name=minimal
   [junit4]   2> 2703106 INFO  (qtp107073346-48727) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.s.IndexSchema Loaded 
schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2703106 INFO  (qtp107073346-48727) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.c.CoreContainer Creating 
SolrCore 'MissingSegmentRecoveryTest_shard1_replica_n2' using configuration 
from collection MissingSegmentRecoveryTest, trusted=true
   [junit4]   2> 2703106 INFO  (qtp107073346-48727) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 
'solr_50601.solr.core.MissingSegmentRecoveryTest.shard1.replica_n2' (registry 
'solr.core.MissingSegmentRecoveryTest.shard1.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d22bbf0
   [junit4]   2> 2703106 INFO  (qtp107073346-48727) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.c.SolrCore 
[[MissingSegmentRecoveryTest_shard1_replica_n2] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.MissingSegmentRecoveryTest_B4301A40F3DF8372-001\tempDir-001\node1\MissingSegmentRecoveryTest_shard1_replica_n2],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.MissingSegmentRecoveryTest_B4301A40F3DF8372-001\tempDir-001\node1\.\MissingSegmentRecoveryTest_shard1_replica_n2\data\]
   [junit4]   2> 2703222 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2703222 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2703223 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 2703223 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 2703230 INFO  (qtp107073346-48727) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2703230 INFO  (qtp107073346-48727) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2703232 INFO  (qtp107073346-48727) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 2703232 INFO  (qtp107073346-48727) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 2703236 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@14742754[MissingSegmentRecoveryTest_shard1_replica_n1] main]
   [junit4]   2> 2703239 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 2703240 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage 
Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2703240 INFO  (qtp107073346-48727) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@1491c6b0[MissingSegmentRecoveryTest_shard1_replica_n2] main]
   [junit4]   2> 2703240 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.h.ReplicationHandler 
Commits will be reserved for 10000ms.
   [junit4]   2> 2703241 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1636179473639407616
   [junit4]   2> 2703243 INFO  (qtp107073346-48727) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 2703243 INFO  (qtp107073346-48727) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.r.ManagedResourceStorage 
Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2703243 INFO  
(searcherExecutor-14572-thread-1-processing-n:127.0.0.1:50598_solr 
x:MissingSegmentRecoveryTest_shard1_replica_n1 c:MissingSegmentRecoveryTest 
s:shard1 r:core_node3) [n:127.0.0.1:50598_solr c:MissingSegmentRecoveryTest 
s:shard1 r:core_node3 x:MissingSegmentRecoveryTest_shard1_replica_n1 ] 
o.a.s.c.SolrCore [MissingSegmentRecoveryTest_shard1_replica_n1] Registered new 
searcher Searcher@14742754[MissingSegmentRecoveryTest_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2703244 INFO  (qtp107073346-48727) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.h.ReplicationHandler 
Commits will be reserved for 10000ms.
   [junit4]   2> 2703244 INFO  (qtp107073346-48727) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1636179473642553344
   [junit4]   2> 2703247 INFO  
(searcherExecutor-14573-thread-1-processing-n:127.0.0.1:50601_solr 
x:MissingSegmentRecoveryTest_shard1_replica_n2 c:MissingSegmentRecoveryTest 
s:shard1 r:core_node4) [n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest 
s:shard1 r:core_node4 x:MissingSegmentRecoveryTest_shard1_replica_n2 ] 
o.a.s.c.SolrCore [MissingSegmentRecoveryTest_shard1_replica_n2] Registered new 
searcher Searcher@1491c6b0[MissingSegmentRecoveryTest_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2703250 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.c.ZkShardTerms 
Successful update of terms at 
/collections/MissingSegmentRecoveryTest/terms/shard1 to 
Terms{values={core_node3=0}, version=0}
   [junit4]   2> 2703250 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/MissingSegmentRecoveryTest/leaders/shard1
   [junit4]   2> 2703256 INFO  (qtp107073346-48727) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.c.ZkShardTerms 
Successful update of terms at 
/collections/MissingSegmentRecoveryTest/terms/shard1 to 
Terms{values={core_node3=0, core_node4=0}, version=1}
   [junit4]   2> 2703256 INFO  (qtp107073346-48727) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/MissingSegmentRecoveryTest/leaders/shard1
   [junit4]   2> 2703265 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2703265 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 2703265 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync 
replicas to 
http://127.0.0.1:50598/solr/MissingSegmentRecoveryTest_shard1_replica_n1/
   [junit4]   2> 2703267 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.u.PeerSync PeerSync: 
core=MissingSegmentRecoveryTest_shard1_replica_n1 
url=http://127.0.0.1:50598/solr START 
replicas=[http://127.0.0.1:50601/solr/MissingSegmentRecoveryTest_shard1_replica_n2/]
 nUpdates=100
   [junit4]   2> 2703267 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.u.PeerSync PeerSync: 
core=MissingSegmentRecoveryTest_shard1_replica_n1 
url=http://127.0.0.1:50598/solr DONE.  We have no versions.  sync failed.
   [junit4]   2> 2703270 INFO  (qtp107073346-48733) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.c.S.Request 
[MissingSegmentRecoveryTest_shard1_replica_n2]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2703270 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.c.SyncStrategy Leader's 
attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 2703270 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_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> 2703270 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/MissingSegmentRecoveryTest/leaders/shard1/leader after winning as 
/collections/MissingSegmentRecoveryTest/leader_elect/shard1/election/72063153472733191-core_node3-n_0000000000
   [junit4]   2> 2703274 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:50598/solr/MissingSegmentRecoveryTest_shard1_replica_n1/ shard1
   [junit4]   2> 2703378 INFO  (zkCallback-17955-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/MissingSegmentRecoveryTest/state.json] for collection 
[MissingSegmentRecoveryTest] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2703379 INFO  (zkCallback-17955-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/MissingSegmentRecoveryTest/state.json] for collection 
[MissingSegmentRecoveryTest] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2703380 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.c.ZkController I am the 
leader, no recovery necessary
   [junit4]   2> 2703387 INFO  (qtp1824388596-48728) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=MissingSegmentRecoveryTest_shard1_replica_n1&action=CREATE&numShards=1&collection=MissingSegmentRecoveryTest&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1321
   [junit4]   2> 2703489 INFO  (zkCallback-17955-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/MissingSegmentRecoveryTest/state.json] for collection 
[MissingSegmentRecoveryTest] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2703489 INFO  (zkCallback-17955-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/MissingSegmentRecoveryTest/state.json] for collection 
[MissingSegmentRecoveryTest] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2703490 INFO  (zkCallback-17955-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/MissingSegmentRecoveryTest/state.json] for collection 
[MissingSegmentRecoveryTest] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2704270 INFO  (qtp107073346-48727) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=MissingSegmentRecoveryTest_shard1_replica_n2&action=CREATE&numShards=1&collection=MissingSegmentRecoveryTest&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2203
   [junit4]   2> 2704276 INFO  (qtp1824388596-48724) [n:127.0.0.1:50598_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> 2704370 INFO  (zkCallback-17959-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/MissingSegmentRecoveryTest/state.json] for collection 
[MissingSegmentRecoveryTest] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2704370 INFO  (zkCallback-17955-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/MissingSegmentRecoveryTest/state.json] for collection 
[MissingSegmentRecoveryTest] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2704370 INFO  (zkCallback-17955-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/MissingSegmentRecoveryTest/state.json] for collection 
[MissingSegmentRecoveryTest] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2704370 INFO  (zkCallback-17955-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/MissingSegmentRecoveryTest/state.json] for collection 
[MissingSegmentRecoveryTest] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2704370 INFO  (zkCallback-17959-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/MissingSegmentRecoveryTest/state.json] for collection 
[MissingSegmentRecoveryTest] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2704381 INFO  (qtp1824388596-48724) [n:127.0.0.1:50598_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={collection.configName=conf&maxShardsPerNode=1&name=MissingSegmentRecoveryTest&nrtReplicas=2&action=CREATE&numShards=1&wt=javabin&version=2}
 status=0 QTime=2644
   [junit4]   2> 2704382 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.c.SolrCloudTestCase active replica count: 2 expected replica count: 2
   [junit4]   2> 2704391 INFO  (qtp1824388596-48730) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.c.ZkShardTerms 
Successful update of terms at 
/collections/MissingSegmentRecoveryTest/terms/shard1 to 
Terms{values={core_node3=1, core_node4=1}, version=2}
   [junit4]   2> 2704396 INFO  (qtp107073346-48738) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] 
o.a.s.u.p.LogUpdateProcessorFactory 
[MissingSegmentRecoveryTest_shard1_replica_n2]  webapp=/solr path=/update 
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:50598/solr/MissingSegmentRecoveryTest_shard1_replica_n1/&wt=javabin&version=2}{add=[0
 (1636179474838978560), 1 (1636179474843172864), 2 (1636179474843172865), 3 
(1636179474843172866), 4 (1636179474843172867), 5 (1636179474843172868), 6 
(1636179474843172869), 7 (1636179474843172870), 8 (1636179474843172871), 9 
(1636179474843172872)]} 0 3
   [junit4]   2> 2704397 INFO  (qtp1824388596-48730) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] 
o.a.s.u.p.LogUpdateProcessorFactory 
[MissingSegmentRecoveryTest_shard1_replica_n1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[0 (1636179474838978560), 1 
(1636179474843172864), 2 (1636179474843172865), 3 (1636179474843172866), 4 
(1636179474843172867), 5 (1636179474843172868), 6 (1636179474843172869), 7 
(1636179474843172870), 8 (1636179474843172871), 9 (1636179474843172872)]} 0 11
   [junit4]   2> 2704398 INFO  (qtp1824388596-48732) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.u.DirectUpdateHandler2 
start 
commit{_version_=1636179474852610048,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2704398 INFO  (qtp1824388596-48732) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.u.SolrIndexWriter 
Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@405114a2 
commitCommandVersion:1636179474852610048
   [junit4]   2> 2704398 INFO  (qtp107073346-48739) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.u.DirectUpdateHandler2 
start 
commit{_version_=1636179474852610048,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2704398 INFO  (qtp107073346-48739) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.u.SolrIndexWriter 
Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@7c0a9d96 
commitCommandVersion:1636179474852610048
   [junit4]   2> 2704429 INFO  (qtp1824388596-48732) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@5e688f97[MissingSegmentRecoveryTest_shard1_replica_n1] main]
   [junit4]   2> 2704429 INFO  (qtp1824388596-48732) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] o.a.s.u.DirectUpdateHandler2 
end_commit_flush
   [junit4]   2> 2704431 INFO  
(searcherExecutor-14572-thread-1-processing-n:127.0.0.1:50598_solr 
x:MissingSegmentRecoveryTest_shard1_replica_n1 c:MissingSegmentRecoveryTest 
s:shard1 r:core_node3) [n:127.0.0.1:50598_solr c:MissingSegmentRecoveryTest 
s:shard1 r:core_node3 x:MissingSegmentRecoveryTest_shard1_replica_n1 ] 
o.a.s.c.SolrCore [MissingSegmentRecoveryTest_shard1_replica_n1] Registered new 
searcher Searcher@5e688f97[MissingSegmentRecoveryTest_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.2.0):C10:[diagnostics={os=Windows
 10, java.vendor=Oracle Corporation, java.version=13-ea, 
java.vm.version=13-ea+18, lucene.version=8.2.0, os.arch=amd64, 
java.runtime.version=13-ea+18, source=flush, os.version=10.0, 
timestamp=1560382342208}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 2704431 INFO  (qtp107073346-48739) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@7d07b43d[MissingSegmentRecoveryTest_shard1_replica_n2] main]
   [junit4]   2> 2704432 INFO  (qtp107073346-48739) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.u.DirectUpdateHandler2 
end_commit_flush
   [junit4]   2> 2704433 INFO  
(searcherExecutor-14573-thread-1-processing-n:127.0.0.1:50601_solr 
x:MissingSegmentRecoveryTest_shard1_replica_n2 c:MissingSegmentRecoveryTest 
s:shard1 r:core_node4) [n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest 
s:shard1 r:core_node4 x:MissingSegmentRecoveryTest_shard1_replica_n2 ] 
o.a.s.c.SolrCore [MissingSegmentRecoveryTest_shard1_replica_n2] Registered new 
searcher Searcher@7d07b43d[MissingSegmentRecoveryTest_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.2.0):C10:[diagnostics={os=Windows
 10, java.vendor=Oracle Corporation, java.version=13-ea, 
java.vm.version=13-ea+18, lucene.version=8.2.0, os.arch=amd64, 
java.runtime.version=13-ea+18, source=flush, os.version=10.0, 
timestamp=1560382342209}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 2704433 INFO  (qtp107073346-48739) [n:127.0.0.1:50601_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] 
o.a.s.u.p.LogUpdateProcessorFactory 
[MissingSegmentRecoveryTest_shard1_replica_n2]  webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:50598/solr/MissingSegmentRecoveryTest_shard1_replica_n1/&commit_end_point=replicas&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 35
   [junit4]   2> 2704434 INFO  (qtp1824388596-48732) [n:127.0.0.1:50598_solr 
c:MissingSegmentRecoveryTest s:shard1 r:core_node3 
x:MissingSegmentRecoveryTest_shard1_replica_n1 ] 
o.a.s.u.p.LogUpdateProcessorFactory 
[MissingSegmentRecoveryTest_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=MissingSegmentRecoveryTest:5&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 36
   [junit4]   2> 2704436 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=180057347
   [junit4]   2> 2704437 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:50601_solr
   [junit4]   2> 2704437 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.c.ZkController Publish this node as DOWN...
   [junit4]   2> 2704437 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.c.ZkController Publish node=127.0.0.1:50601_solr as DOWN
   [junit4]   2> 2704440 INFO  (coreCloseExecutor-14582-thread-1) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.c.SolrCore 
[MissingSegmentRecoveryTest_shard1_replica_n2]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@61eee44d
   [junit4]   2> 2704440 INFO  (coreCloseExecutor-14582-thread-1) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.m.SolrMetricManager 
Closing metric reporters for 
registry=solr.core.MissingSegmentRecoveryTest.shard1.replica_n2, tag=61eee44d
   [junit4]   2> 2704440 INFO  (coreCloseExecutor-14582-thread-1) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter 
Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6c30031c: 
rootName = solr_50601, domain = 
solr.core.MissingSegmentRecoveryTest.shard1.replica_n2, service url = null, 
agent id = null] for registry 
solr.core.MissingSegmentRecoveryTest.shard1.replica_n2 / 
com.codahale.metrics.MetricRegistry@27364c64
   [junit4]   2> 2704449 INFO  (coreCloseExecutor-14582-thread-1) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.m.SolrMetricManager 
Closing metric reporters for 
registry=solr.collection.MissingSegmentRecoveryTest.shard1.leader, tag=61eee44d
   [junit4]   2> 2704453 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 2704453 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@3e92dbd4: rootName = 
solr_50601, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@3c4859d8
   [junit4]   2> 2704459 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 2704459 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@5d8795ba: rootName = 
solr_50601, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@61830072
   [junit4]   2> 2704463 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jetty, tag=null
   [junit4]   2> 2704463 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@61b15857: rootName = 
solr_50601, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@37388102
   [junit4]   2> 2704463 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.cluster, tag=null
   [junit4]   2> 2704464 INFO  (zkCallback-17972-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 2704464 INFO  (zkCallback-17955-thread-2) [     ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:50598_solr
   [junit4]   2> 2704464 INFO  (zkCallback-17978-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 2704464 INFO  (zkCallback-17966-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 2704464 INFO  (zkCallback-17955-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 2704468 INFO  (closeThreadPool-17985-thread-2) [     ] 
o.a.s.c.Overseer Overseer 
(id=72063153472733192-127.0.0.1:50601_solr-n_0000000000) closing
   [junit4]   2> 2704468 INFO  
(OverseerStateUpdate-72063153472733192-127.0.0.1:50601_solr-n_0000000000) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:50601_solr
   [junit4]   2> 2704471 INFO  
(OverseerAutoScalingTriggerThread-72063153472733192-127.0.0.1:50601_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 2704472 INFO  (zkCallback-17955-thread-2) 
[n:127.0.0.1:50598_solr     ] o.a.s.c.Overseer Overseer 
(id=72063153472733191-127.0.0.1:50598_solr-n_0000000001) starting
   [junit4]   2> 2704472 INFO  (closeThreadPool-17985-thread-1) [     ] 
o.a.s.c.Overseer Overseer 
(id=72063153472733192-127.0.0.1:50601_solr-n_0000000000) closing
   [junit4]   2> 2704479 INFO  
(OverseerStateUpdate-72063153472733191-127.0.0.1:50598_solr-n_0000000001) 
[n:127.0.0.1:50598_solr     ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:50598_solr
   [junit4]   2> 2704485 INFO  (zkCallback-17955-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/MissingSegmentRecoveryTest/state.json] for collection 
[MissingSegmentRecoveryTest] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 2704485 INFO  (zkCallback-17955-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/MissingSegmentRecoveryTest/state.json] for collection 
[MissingSegmentRecoveryTest] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 2704485 INFO  (zkCallback-17955-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/MissingSegmentRecoveryTest/state.json] for collection 
[MissingSegmentRecoveryTest] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 2704565 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.c.Overseer Overseer 
(id=72063153472733192-127.0.0.1:50601_solr-n_0000000000) closing
   [junit4]   2> 2704667 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@4d5ddb6b{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
   [junit4]   2> 2704669 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@75edd4c2{/solr,null,UNAVAILABLE}
   [junit4]   2> 2704670 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 2704671 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 2704671 WARN  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 2704671 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 50601 try number 
1 ...
   [junit4]   2> 2704672 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; 
git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 13-ea+18
   [junit4]   2> 2704673 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2704673 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2704673 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 2704673 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6ed9a81c{/solr,null,AVAILABLE}
   [junit4]   2> 2704673 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.e.j.s.AbstractConnector Started 
ServerConnector@4bc17a2d{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:50601}
   [junit4]   2> 2704673 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.e.j.s.Server Started @2704708ms
   [junit4]   2> 2704673 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=50601}
   [junit4]   2> 2704673 ERROR 
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may 
be missing or incomplete.
   [junit4]   2> 2704673 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2704673 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 8.2.0
   [junit4]   2> 2704673 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on 
port null
   [junit4]   2> 2704673 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2704673 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-06-12T23:32:22.473270200Z
   [junit4]   2> 2704679 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2704688 INFO  (zkConnectionManagerCallback-17987-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2704689 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2704690 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2705497 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 2705499 WARN  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured 
for SslContextFactory@15d75c7d[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2705505 WARN  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured 
for SslContextFactory@63dbfc9a[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2705507 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50585/solr
   [junit4]   2> 2705508 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2705511 INFO  (zkConnectionManagerCallback-17994-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2705511 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) [  
   ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2705629 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 2705632 INFO  (zkConnectionManagerCallback-17996-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2705632 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 2705640 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2705646 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.ZkController Publish 
node=127.0.0.1:50601_solr as DOWN
   [junit4]   2> 2705647 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 2705647 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:50601_solr
   [junit4]   2> 2705649 INFO  (zkCallback-17955-thread-4) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2705649 INFO  (zkCallback-17978-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2705651 INFO  (zkCallback-17995-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2705652 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 2705653 INFO  (zkCallback-17972-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2705655 INFO  (zkConnectionManagerCallback-18003-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2705655 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 2705658 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 2705660 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:50585/solr ready
   [junit4]   2> 2705696 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) 
[n:127.0.0.1:50601_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 2705735 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) 
[n:127.0.0.1:50601_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_50601.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d22bbf0
   [junit4]   2> 2705753 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) 
[n:127.0.0.1:50601_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_50601.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d22bbf0
   [junit4]   2> 2705753 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) 
[n:127.0.0.1:50601_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_50601.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d22bbf0
   [junit4]   2> 2705755 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.CorePropertiesLocator Found 1 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.MissingSegmentRecoveryTest_B4301A40F3DF8372-001\tempDir-001\node1\.
   [junit4]   2> 2705755 INFO  
(TEST-MissingSegmentRecoveryTest.testLeaderRecovery-seed#[B4301A40F3DF8372]) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.CorePropertiesLocator Cores are: 
[MissingSegmentRecoveryTest_shard1_replica_n2]
   [junit4]   2> 2705765 INFO  (zkCallback-17955-thread-4) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/MissingSegmentRecoveryTest/state.json] for collection 
[MissingSegmentRecoveryTest] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2705765 INFO  (zkCallback-17955-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/MissingSegmentRecoveryTest/state.json] for collection 
[MissingSegmentRecoveryTest] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2705765 INFO  (zkCallback-17955-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/MissingSegmentRecoveryTest/state.json] for collection 
[MissingSegmentRecoveryTest] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2705780 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 
8.2.0
   [junit4]   2> 2705791 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr     ] o.a.s.s.IndexSchema 
[MissingSegmentRecoveryTest_shard1_replica_n2] Schema name=minimal
   [junit4]   2> 2705793 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr     ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 
with uniqueid field id
   [junit4]   2> 2705804 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 8.2.0
   [junit4]   2> 2705850 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.s.IndexSchema 
[MissingSegmentRecoveryTest_shard1_replica_n2] Schema name=minimal
   [junit4]   2> 2705853 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.s.IndexSchema Loaded 
schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2705853 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.c.CoreContainer Creating 
SolrCore 'MissingSegmentRecoveryTest_shard1_replica_n2' using configuration 
from collection MissingSegmentRecoveryTest, trusted=true
   [junit4]   2> 2705853 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 
'solr_50601.solr.core.MissingSegmentRecoveryTest.shard1.replica_n2' (registry 
'solr.core.MissingSegmentRecoveryTest.shard1.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d22bbf0
   [junit4]   2> 2705853 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.c.SolrCore 
[[MissingSegmentRecoveryTest_shard1_replica_n2] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.MissingSegmentRecoveryTest_B4301A40F3DF8372-001\tempDir-001\node1\MissingSegmentRecoveryTest_shard1_replica_n2],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.MissingSegmentRecoveryTest_B4301A40F3DF8372-001\tempDir-001\node1\.\MissingSegmentRecoveryTest_shard1_replica_n2\data\]
   [junit4]   2> 2705949 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2705949 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2705951 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 2705951 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 2705958 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.c.SolrCore 
[MissingSegmentRecoveryTest_shard1_replica_n2]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@2b8ce9b9
   [junit4]   2> 2705958 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.m.SolrMetricManager 
Closing metric reporters for 
registry=solr.core.MissingSegmentRecoveryTest.shard1.replica_n2, tag=2b8ce9b9
   [junit4]   2> 2705958 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter 
Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@41e8694d: 
rootName = solr_50601, domain = 
solr.core.MissingSegmentRecoveryTest.shard1.replica_n2, service url = null, 
agent id = null] for registry 
solr.core.MissingSegmentRecoveryTest.shard1.replica_n2 / 
com.codahale.metrics.MetricRegistry@2f5ddc15
   [junit4]   2> 2705970 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.m.SolrMetricManager 
Closing metric reporters for 
registry=solr.collection.MissingSegmentRecoveryTest.shard1.leader, tag=2b8ce9b9
   [junit4]   2> 2705975 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.c.CoreContainer Found 
active leader, will attempt to create fresh core and recover.
   [junit4]   2> 2705975 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.c.SolrCore Updating 
index properties... index=index.20190612163223775
   [junit4]   2> 2705986 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.c.ZkShardTerms 
Successful update of terms at 
/collections/MissingSegmentRecoveryTest/terms/shard1 to 
Terms{values={core_node3=1, core_node4=0}, version=3}
   [junit4]   2> 2706009 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 
'solr_50601.solr.core.MissingSegmentRecoveryTest.shard1.replica_n2' (registry 
'solr.core.MissingSegmentRecoveryTest.shard1.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d22bbf0
   [junit4]   2> 2706009 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.c.SolrCore 
[[MissingSegmentRecoveryTest_shard1_replica_n2] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.MissingSegmentRecoveryTest_B4301A40F3DF8372-001\tempDir-001\node1\MissingSegmentRecoveryTest_shard1_replica_n2],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.MissingSegmentRecoveryTest_B4301A40F3DF8372-001\tempDir-001\node1\.\MissingSegmentRecoveryTest_shard1_replica_n2\data\]
   [junit4]   2> 2706028 INFO  
(OldIndexDirectoryCleanupThreadForCore-MissingSegmentRecoveryTest_shard1_replica_n2)
 [     ] o.a.s.c.DirectoryFactory Found 1 old index directories to clean-up 
under 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.MissingSegmentRecoveryTest_B4301A40F3DF8372-001\tempDir-001\node1\.\MissingSegmentRecoveryTest_shard1_replica_n2\data\
 afterReload=false
   [junit4]   2> 2706098 INFO  
(OldIndexDirectoryCleanupThreadForCore-MissingSegmentRecoveryTest_shard1_replica_n2)
 [     ] o.a.s.c.DirectoryFactory Deleted old index directory: 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.MissingSegmentRecoveryTest_B4301A40F3DF8372-001\tempDir-001\node1\.\MissingSegmentRecoveryTest_shard1_replica_n2\data\index.20190612163223775
   [junit4]   2> 2706108 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2706108 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2706110 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 2706110 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 2706117 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.c.SolrCore 
[MissingSegmentRecoveryTest_shard1_replica_n2]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@2244f0c5
   [junit4]   2> 2706117 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.m.SolrMetricManager 
Closing metric reporters for 
registry=solr.core.MissingSegmentRecoveryTest.shard1.replica_n2, tag=2244f0c5
   [junit4]   2> 2706117 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter 
Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@520225dd: 
rootName = solr_50601, domain = 
solr.core.MissingSegmentRecoveryTest.shard1.replica_n2, service url = null, 
agent id = null] for registry 
solr.core.MissingSegmentRecoveryTest.shard1.replica_n2 / 
com.codahale.metrics.MetricRegistry@2f5ddc15
   [junit4]   2> 2706130 INFO  
(coreLoadExecutor-14596-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr c:MissingSegmentRecoveryTest s:shard1 r:core_node4 
x:MissingSegmentRecoveryTest_shard1_replica_n2 ] o.a.s.m.SolrMetricManager 
Closing metric reporters for 
registry=solr.collection.MissingSegmentRecoveryTest.shard1.leader, tag=2244f0c5
   [junit4]   2> 2706131 INFO  
(OldIndexDirectoryCleanupThreadForCore-MissingSegmentRecoveryTest_shard1_replica_n2)
 [     ] o.a.s.c.DirectoryFactory Found 1 old index directories to clean-up 
under 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.MissingSegmentRecoveryTest_B4301A40F3DF8372-001\tempDir-001\node1\.\MissingSegmentRecoveryTest_shard1_replica_n2\data\
 afterReload=false
   [junit4]   2> 2706144 INFO  
(OldIndexDirectoryCleanupThreadForCore-MissingSegmentRecoveryTest_shard1_replica_n2)
 [     ] o.a.s.c.DirectoryFactory Deleted old index directory: 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.MissingSegmentRecoveryTest_B4301A40F3DF8372-001\tempDir-001\node1\.\MissingSegmentRecoveryTest_shard1_replica_n2\data\index
   [junit4]   2> 2706144 ERROR 
(coreContainerWorkExecutor-14589-thread-1-processing-n:127.0.0.1:50601_solr) 
[n:127.0.0.1:50601_solr     ] o.a.s.c.CoreContainer Error waiting for SolrCore 
to be loaded on startup
   [junit4]   2>           => org.apache.solr.common.SolrException: Unable to 
create core [MissingSegmentRecoveryTest_shard1_replica_n2]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1262)
   [junit4]   2> org.apache.solr.common.SolrException: Unable to create core 
[MissingSegmentRecoveryTest_shard1_replica_n2]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1262)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:752) 
~[java/:?]
   [junit4]   2>        at 
com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202)
 ~[metrics-core-4.0.5.jar:4.0.5]
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:264) ~[?:?]
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
 ~[java/:?]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) 
~[?:?]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) 
~[?:?]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:835) [?:?]
   [junit4]   2> Caused by: org.apache.solr.common.SolrException: Error opening 
new searcher
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.<init>(SolrCore.java:1053) ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.<init>(SolrCore.java:879) ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.processCoreCreateException(CoreContainer.java:1339)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1243)
 ~[java/:?]
   [junit4]   2>        ... 7 more
   [junit4]   2>        Suppressed: org.apache.solr.common.SolrException: Error 
opening new searcher
   [junit4]   2>                at 
org.apache.solr.core.SolrCore.<init>(SolrCore.java:1053) ~[java/:?]
   [junit4]   2>                at 
org.apache.solr.core.SolrCore.<init>(SolrCore.java:879) ~[java/:?]
   [junit4]   2>                at 
org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1241)
 ~[java/:?]
   [junit4]   2>                at 
org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:752) 
~[java/:?]
   [junit4]   2>                at 
com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:202)
 ~[metrics-core-4.0.5.jar:4.0.5]
   [junit4]   2>                at 
java.util.concurrent.FutureTask.run(FutureTask.java:264) ~[?:?]
   [junit4]   2>                at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
 ~[java/:?]
   [junit4]   2>                at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) 
~[?:?]
   [junit4]   2>                at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) 
~[?:?]
   [junit4]   2>                at java.lang.Thread.run(Thread.java:835) [?:?]
   [junit4]   2>        Caused by: org.apache.solr.common.SolrException: Error 
opening new searcher
   [junit4]   2>                at 
org.apache.solr.core.SolrCore.openNewSearcher(SolrCore.java:2151) ~[java/:?]
   [junit4]   2>                at 
org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:2271) ~[java/:?]
   [junit4]   2>                at 
org.apache.solr.core.SolrCore.initSearcher(SolrCore.java:1111) ~[java/:?]
   [junit4]   2>                at 
org.apache.solr.core.SolrCore.<init>(SolrCore.java:998) ~[java/:?]
   [junit4]   2>                ... 9 more
   [junit4]   2>        Caused by: 
org.apache.lucene.index.CorruptIndexException: Unexpected file read error while 
reading index. 
(resource=BufferedChecksumIndexInput(MMapIndexInput(path="C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.MissingSegmentRecoveryTest_B4301A40F3DF8372-001\tempDir-001\node1\MissingSegmentRecoveryTest_shard1_replica_n2\data\index\segments_2")))
   [junit4]   2>                at 
org.apache.lucene.index.SegmentInfos.readCommit(SegmentInfos.java:291) 
~[java/:?]
   [junit4]   2>                at 
org.apache.lucene.index.IndexWriter.<init>(IndexWriter.java:846) ~[java/:?]
   [junit4]   2>                at 
org.apache.solr.update.SolrIndexWriter.<init>(SolrIndexWriter.java:128) 
~[java/:?]
   [junit4]   2>                at 
org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:101) 
~[java/:?]
   [junit4]   2>                at 
org.apache.solr.update.DefaultSolrCoreState.createMainIndexWriter(DefaultSolrCoreState.java:260)
 ~[java/:?]
   [junit4]   2>                at 
org.apache.solr.update.DefaultSolrCoreState.getIndexWriter(DefaultSolrCoreState.java:134)
 ~[java/:?]
   [junit4]   2>                at 
org.apache.solr.core.SolrCore.openNewSearcher(SolrCore.java:2112) ~[java/:?]
   [junit4]   2>                at 
org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:2271) ~[java/:?]
   [junit4]   2>                at 
org.apache.solr.core.SolrCore.initSearcher(SolrCore.java:1111) ~[java/:?]
   [junit4]   2>                at 
org.apache.solr.core.SolrCore.<init>(SolrCore.java:998) ~[java/:?]
   [junit4]   2>                ... 9 more
   [junit4]   2>        Caused by: java.io.EOFException: read past EOF: 
MMapIndexInput(path="C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.MissingSegmentRecoveryTest_B4301A40F3DF8372-001\tempDir-001\node1\MissingSegmentRecoveryTest_shard1_replica_n2\data\index\segments_2")
   [junit4]   2>                at 
org.apache.lucene.store.ByteBufferIndexInput.readByte(ByteBufferIndexInput.java:75)
 ~[java/:?]
   [junit4]   2>                at 
org.apache.lucene.store.BufferedChecksumIndexInput.readByte(BufferedChecksumIndexInput.java:41)
 ~[java/:?]
   [junit4]   2>                at 
org.apache.lucene.store.DataInput.readInt(DataInput.java:101) ~[java/:?]
   [junit4]   2>                at 
org.apache.lucene.index.SegmentInfos.readCommit(SegmentInfos.java:301) 
~[java/:?]
   [junit4]   2>                at 
org.apache.lucene.index.SegmentInfos.readCommit(SegmentInfos.java:289) 
~[java/:?]
   [junit4]   2>                at 
org.apache.lucene.index.IndexWriter.<init>(IndexWriter.java:846) ~[java/:?]
   [junit4]   2>                at 
org.apache.solr.update.SolrIndexWriter.<init>(SolrIndexWriter.java:128) 
~[java/:?]
   [junit4]   2>                at 
org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:101) 
~[java/:?]
   [junit4]   2>                at 
org.apache.solr.update.DefaultSolrCoreState.createMainIndexWriter(DefaultSolrCoreState.java:260)
 ~[java/:?]
   [junit4]   2>                at 
org.apache.solr.update.DefaultSolrCoreState.getIndexWriter(DefaultSolrCoreState.java:134)
 ~[java/:?]
   [junit4]   2>                at 
org.apache.solr.core.SolrCore.openNewSearcher(SolrCore.java:2112) ~[java/:?]
   [junit4]   2>                at 
org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:2271) ~[java/:?]
   [junit4]   2>                at 
org.apache.solr.core.SolrCore.initSearcher(SolrCore.java:1111) ~[java/:?]
   [junit4]   2>                at 
org.apache.solr.core.SolrCore.<init>(SolrCore.java:998) ~[java/:?]
   [junit4]   2>                ... 9 more
   [junit4]   2> Caused by: org.apache.solr.common.SolrException: Error opening 
new searcher
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.openNewSearcher(SolrCore.java:2151) ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:2271) ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.initSearcher(SolrCore.java:1111) ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.<init>(SolrCore.java:998) ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.<init>(SolrCore.java:879) ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.processCoreCreateException(CoreContainer.java:1339)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1243)
 ~[java/:?]
   [junit4]   2>        ... 7 more
   [junit4]   2> Caused by: org.apache.lucene.index.IndexNotFoundException: no 
segments* file found in 
LockValidatingDirectoryWrapper(MMapDirectory@C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.MissingSegmentRecoveryTest_B4301A40F3DF8372-001\tempDir-001\node1\MissingSegmentRecoveryTest_shard1_replica_n2\data\index.20190612163223775
 lockFactory=org.apache.lucene.store.NativeFSLockFactory@6edb9f4): files: 
[write.lock]
   [junit4]   2>        at 
org.apache.lucene.index.IndexWriter.<init>(IndexWriter.java:841) ~[java/:?]
   [junit4]   2>        at org.apache.solr.update.SolrIndexWriter.<init>(Solr

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

t create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        9       /solr/clusterprops.json
   [junit4]   2>        9       /solr/aliases.json
   [junit4]   2>        4       /solr/security.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        9       /solr/clusterstate.json
   [junit4]   2>        5       /solr/autoscaling.json
   [junit4]   2>        2       
/solr/overseer_elect/election/72063157245771790-127.0.0.1:51181_solr-n_0000000005
   [junit4]   2>        2       
/solr/overseer_elect/election/72063157245771793-127.0.0.1:51189_solr-n_0000000005
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        37      /solr/live_nodes
   [junit4]   2>        34      /solr/overseer/collection-queue-work
   [junit4]   2>        19      /solr/overseer/queue
   [junit4]   2>        9       /solr/collections
   [junit4]   2>        5       /solr/autoscaling/events/.scheduled_maintenance
   [junit4]   2>        5       /solr/autoscaling/events/.auto_add_replicas
   [junit4]   2>        5       /solr/overseer/queue-work
   [junit4]   2> 
   [junit4]   2> 2776323 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[B4301A40F3DF8372]) [     ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:51167
   [junit4]   2> 2776323 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[B4301A40F3DF8372]) [     ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 51167
   [junit4]   2> 2777325 INFO  
(TEST-OverseerRolesTest.testOverseerRole-seed#[B4301A40F3DF8372]) [     ] 
o.a.s.SolrTestCaseJ4 ###Ending testOverseerRole
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=OverseerRolesTest 
-Dtests.method=testOverseerRole -Dtests.seed=B4301A40F3DF8372 -Dtests.slow=true 
-Dtests.locale=bs -Dtests.timezone=NZ -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] FAILURE 19.2s J1 | OverseerRolesTest.testOverseerRole <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: Timed out waiting for 
overseer state change. The current overseer is: 127.0.0.1:51189_solr
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([B4301A40F3DF8372:55FBE7D4C86CB5A3]:0)
   [junit4]    >        at 
org.apache.solr.cloud.OverseerRolesTest.waitForNewOverseer(OverseerRolesTest.java:75)
   [junit4]    >        at 
org.apache.solr.cloud.OverseerRolesTest.testOverseerRole(OverseerRolesTest.java:162)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]    >        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]    >        at 
java.base/java.lang.reflect.Method.invoke(Method.java:567)
   [junit4]    >        at java.base/java.lang.Thread.run(Thread.java:835)
   [junit4]   2> NOTE: leaving temporary files on disk at: 
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.OverseerRolesTest_B4301A40F3DF8372-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene80): {}, 
docValues:{}, maxPointsInLeafNode=858, maxMBSortInHeap=7.329142666963325, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@6f10b6fb),
 locale=bs, timezone=NZ
   [junit4]   2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 13-ea 
(64-bit)/cpus=3,threads=1,free=218017392,total=495976448
   [junit4]   2> NOTE: All tests run in this JVM: [TestTrieFacet, 
MinimalSchemaTest, TestFieldTypeCollectionResource, 
TestBackupRepositoryFactory, TestFileDictionaryLookup, 
ChaosMonkeySafeLeaderWithPullReplicasTest, TemplateUpdateProcessorTest, 
LegacyCloudClusterPropTest, TestJsonFacets, TestHalfAndHalfDocValues, 
TestUnInvertedFieldException, TestSimDistributedQueue, SolrRequestParserTest, 
ZkNodePropsTest, MoveReplicaHDFSTest, DeleteNodeTest, TestMergePolicyConfig, 
TestFieldCollectionResource, SpellingQueryConverterTest, TestConfigOverlay, 
FieldMutatingUpdateProcessorTest, SolrJmxReporterCloudTest, TimeZoneUtilsTest, 
TestSolrJ, TestSubQueryTransformerDistrib, TestPseudoReturnFields, 
OverseerTaskQueueTest, ZkSolrClientTest, DistributedSuggestComponentTest, 
ManagedSchemaRoundRobinCloudTest, PluginInfoTest, TestNamedUpdateProcessors, 
TestOrdValues, TestRTimerTree, ScheduledMaintenanceTriggerTest, 
TestRandomFlRTGCloud, ForceLeaderTest, NodeMarkersRegistrationTest, 
ZkControllerTest, TestNumericRangeQuery64, SolrCloudExampleTest, RootFieldTest, 
ScriptEngineTest, BaseCdcrDistributedZkTest, TestStressLiveNodes, 
CollectionsAPIDistributedZkTest, PeerSyncReplicationTest, 
HdfsChaosMonkeySafeLeaderTest, AsyncCallRequestStatusResponseTest, 
TestComplexPhraseQParserPlugin, TestConfigSetProperties, 
TestReplicationHandlerBackup, IndexBasedSpellCheckerTest, PreAnalyzedFieldTest, 
SegmentsInfoRequestHandlerTest, TransactionLogTest, PrimUtilsTest, 
DeleteInactiveReplicaTest, CurrencyFieldTypeTest, TestSimExtremeIndexing, 
NestedShardedAtomicUpdateTest, PolyFieldTest, TestSortableTextField, 
TestQuerySenderListener, TestEmbeddedSolrServerConstructors, 
AutoAddReplicasIntegrationTest, TestHdfsUpdateLog, SparseHLLTest, 
InfoHandlerTest, TestPHPSerializedResponseWriter, TestSchemaSimilarityResource, 
AliasIntegrationTest, SampleTest, PeerSyncWithBufferUpdatesTest, 
TestSimNodeLostTrigger, TestSort, SpatialFilterTest, RuleEngineTest, 
BlockJoinFacetDistribTest, AutoScalingHandlerTest, TestInPlaceUpdatesDistrib, 
ResponseBuilderTest, ExplicitHLLTest, MetricsHandlerTest, 
DirectUpdateHandlerTest, TestDistributedMap, TestFieldCacheSort, 
TestCloudConsistency, StressHdfsTest, RegexBoostProcessorTest, 
TestChildDocTransformer, TestConfigsApi, DOMUtilTest, 
BigEndianAscendingWordSerializerTest, TestManagedSynonymGraphFilterFactory, 
TestUseDocValuesAsStored2, BlockJoinFacetSimpleTest, TestSimpleQParserPlugin, 
TestCloudPivotFacet, LeaderElectionIntegrationTest, 
DistribJoinFromCollectionTest, TestJmxIntegration, TestFieldCache, 
ParsingFieldUpdateProcessorsTest, TestReload, SearchRateTriggerTest, 
PeerSyncWithLeaderAndIndexFingerprintCachingTest, TestSolrDeletionPolicy1, 
TestBulkSchemaAPI, TestMultiValuedNumericRangeQuery, TestManagedSchemaAPI, 
FacetPivotSmallTest, TestSolrCoreParser, SpellCheckCollatorWithCollapseTest, 
EmbeddedSolrNoSerializeTest, TestCloudManagedSchema, RestartWhileUpdatingTest, 
TestConfigSetsAPI, TestPKIAuthenticationPlugin, LeaderTragicEventTest, 
PingRequestHandlerTest, CreateCollectionCleanupTest, 
TestManagedResourceStorage, SuggesterTSTTest, TestNumericTerms64, 
CdcrReplicationHandlerTest, TestExpandComponent, ClusterStateTest, 
CleanupOldIndexTest, TestCodecSupport, TestReqParamsAPI, 
SystemCollectionCompatTest, DaemonStreamApiTest, WrapperMergePolicyFactoryTest, 
LeaderFailoverAfterPartitionTest, SolrPluginUtilsTest, TestSSLRandomization, 
TestCharFilters, SpatialHeatmapFacetsTest, EnumFieldTest, 
VMParamsZkACLAndCredentialsProvidersTest, TestJsonRequest, TestSimpleTextCodec, 
TriLevelCompositeIdRoutingTest, SchemaVersionSpecificBehaviorTest, 
StatsReloadRaceTest, TestTolerantSearch, CdcrVersionReplicationTest, 
TestLuceneMatchVersion, TestFilteredDocIdSet, SolrIndexMetricsTest, 
JsonLoaderTest, TestRandomDVFaceting, TestSolrConfigHandlerCloud, 
SuggestComponentContextFilterQueryTest, TestLegacyNumericUtils, 
TestHdfsCloudBackupRestore, NumberUtilsTest, TestApiFramework, 
BasicAuthOnSingleNodeTest, TestLogWatcher, IndexSchemaRuntimeFieldTest, 
TestRebalanceLeaders, HttpPartitionOnCommitTest, V2StandaloneTest, 
AtomicUpdateRemovalJavabinTest, TestLRUCache, TestInfoStreamLogging, 
HdfsRecoverLeaseTest, RoutingToNodesWithPropertiesTest, 
TestSlowCompositeReaderWrapper, ReplaceNodeTest, 
CategoryRoutedAliasUpdateProcessorTest, TestCoreContainer, TestSchemaManager, 
TestLMDirichletSimilarityFactory, TestShortCircuitedRequests, ShardRoutingTest, 
TestSolr4Spatial, BadIndexSchemaTest, TestNoOpRegenerator, 
TestMaxTokenLenTokenizer, TimeRoutedAliasUpdateProcessorTest, TestLegacyField, 
TestZkChroot, MaxSizeAutoCommitTest, AnalyticsMergeStrategyTest, 
TestUtilizeNode, TestHighlightDedupGrouping, DirectSolrSpellCheckerTest, 
TaggingAttributeTest, TestDirectoryFactory, 
DistributedQueryElevationComponentTest, TestSchemaNameResource, 
SolrCoreCheckLockOnStartupTest, TestStressCloudBlindAtomicUpdates, 
RankQueryTest, TestSystemCollAutoCreate, 
AddSchemaFieldsUpdateProcessorFactoryTest, TestDFRSimilarityFactory, 
ActionThrottleTest, TestConfigReload, HLLSerializationTest, 
TestLegacyFieldCache, RemoteQueryErrorTest, NodeAddedTriggerIntegrationTest, 
TestCollationField, TestDistributedTracing, TestSerializedLuceneMatchVersion, 
OverseerCollectionConfigSetProcessorTest, TestImpersonationWithHadoopAuth, 
TestDistributedMissingSort, TestSimpleTrackingShardHandler, 
PathHierarchyTokenizerFactoryTest, TestWordDelimiterFilterFactory, 
TokenizerChainTest, TestLuceneIndexBackCompat, BasicDistributedZkTest, 
ChaosMonkeySafeLeaderTest, CollectionsAPISolrJTest, 
HttpPartitionWithTlogReplicasTest, MetricsHistoryWithAuthIntegrationTest, 
MissingSegmentRecoveryTest, OverseerRolesTest]
   [junit4] Completed [481/863 (2!)] on J1 in 23.63s, 2 tests, 1 failure <<< 
FAILURES!

[...truncated 66 lines...]
ERROR: command execution failed.
ERROR: Step ‘Archive the artifacts’ failed: no workspace for 
Lucene-Solr-8.x-Windows #305
ERROR: Step ‘[Deprecated] Scan for compiler warnings’ failed: no workspace for 
Lucene-Solr-8.x-Windows #305
ERROR: Step ‘Publish JUnit test result report’ failed: no workspace for 
Lucene-Solr-8.x-Windows #305
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
ERROR: Windows VBOX is offline; cannot locate ANT 1.8.2
Setting ANT_1_8_2_HOME=
ERROR: Windows VBOX is offline; cannot locate ANT 1.8.2
Setting ANT_1_8_2_HOME=
ERROR: Windows VBOX is offline; cannot locate ANT 1.8.2
Setting ANT_1_8_2_HOME=
ERROR: Windows VBOX is offline; cannot locate ANT 1.8.2
Setting ANT_1_8_2_HOME=
ERROR: Windows VBOX is offline; cannot locate ANT 1.8.2
Setting ANT_1_8_2_HOME=
ERROR: Windows VBOX is offline; cannot locate ANT 1.8.2
Setting ANT_1_8_2_HOME=
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to