lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Jenkins Server <jenk...@builds.apache.org>
Subject [JENKINS] Lucene-Solr-Tests-8.1 - Build # 39 - Still Unstable
Date Sun, 05 May 2019 00:13:38 GMT
Build: https://builds.apache.org/job/Lucene-Solr-Tests-8.1/39/

1 tests failed.
FAILED:  org.apache.solr.cloud.ReindexCollectionTest.testFailure

Error Message:


Stack Trace:
java.lang.NullPointerException
	at __randomizedtesting.SeedInfo.seed([6995F41A2F5188AB:12807F61561EA04]:0)
	at org.apache.solr.cloud.ReindexCollectionTest.lambda$testFailure$9(ReindexCollectionTest.java:305)
	at org.apache.solr.common.cloud.ClusterState.lambda$forEachCollection$0(ClusterState.java:359)
	at java.util.LinkedHashMap.forEach(LinkedHashMap.java:684)
	at org.apache.solr.common.cloud.ClusterState.forEachCollection(ClusterState.java:357)
	at org.apache.solr.cloud.ReindexCollectionTest.testFailure(ReindexCollectionTest.java:304)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 14363 lines...]
   [junit4] Suite: org.apache.solr.cloud.ReindexCollectionTest
   [junit4]   2> Creating dataDir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.cloud.ReindexCollectionTest_6995F41A2F5188AB-001/init-core-data-001
   [junit4]   2> 2422531 WARN  (SUITE-ReindexCollectionTest-seed#[6995F41A2F5188AB]-worker) [    ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=30 numCloses=30
   [junit4]   2> 2422531 INFO  (SUITE-ReindexCollectionTest-seed#[6995F41A2F5188AB]-worker) [    ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 2422532 INFO  (SUITE-ReindexCollectionTest-seed#[6995F41A2F5188AB]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 2422533 INFO  (SUITE-ReindexCollectionTest-seed#[6995F41A2F5188AB]-worker) [    ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 2422533 INFO  (SUITE-ReindexCollectionTest-seed#[6995F41A2F5188AB]-worker) [    ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.cloud.ReindexCollectionTest_6995F41A2F5188AB-001/tempDir-001
   [junit4]   2> 2422543 INFO  (SUITE-ReindexCollectionTest-seed#[6995F41A2F5188AB]-worker) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2422555 INFO  (ZkTestServer Run Thread) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2422556 INFO  (ZkTestServer Run Thread) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 2422669 INFO  (SUITE-ReindexCollectionTest-seed#[6995F41A2F5188AB]-worker) [    ] o.a.s.c.ZkTestServer start zk server on port:39674
   [junit4]   2> 2422669 INFO  (SUITE-ReindexCollectionTest-seed#[6995F41A2F5188AB]-worker) [    ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:39674
   [junit4]   2> 2422669 INFO  (SUITE-ReindexCollectionTest-seed#[6995F41A2F5188AB]-worker) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 39674
   [junit4]   2> 2422707 INFO  (zkConnectionManagerCallback-7089-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2422762 INFO  (zkConnectionManagerCallback-7091-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2422786 INFO  (zkConnectionManagerCallback-7093-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2422803 WARN  (jetty-launcher-7094-thread-1) [    ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 2422804 INFO  (jetty-launcher-7094-thread-1) [    ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 2422804 INFO  (jetty-launcher-7094-thread-1) [    ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 2422804 INFO  (jetty-launcher-7094-thread-1) [    ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
   [junit4]   2> 2422809 WARN  (jetty-launcher-7094-thread-2) [    ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 2422810 INFO  (jetty-launcher-7094-thread-2) [    ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 2422810 INFO  (jetty-launcher-7094-thread-2) [    ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 2422810 INFO  (jetty-launcher-7094-thread-2) [    ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
   [junit4]   2> 2422969 INFO  (jetty-launcher-7094-thread-2) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2422969 INFO  (jetty-launcher-7094-thread-2) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2422969 INFO  (jetty-launcher-7094-thread-2) [    ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 2422985 INFO  (jetty-launcher-7094-thread-2) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@113d30be{/solr,null,AVAILABLE}
   [junit4]   2> 2422986 WARN  (jetty-launcher-7094-thread-2) [    ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@6bddd640[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2423017 INFO  (jetty-launcher-7094-thread-1) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2423017 INFO  (jetty-launcher-7094-thread-1) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2423018 INFO  (jetty-launcher-7094-thread-1) [    ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 2423018 INFO  (jetty-launcher-7094-thread-1) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@16116964{/solr,null,AVAILABLE}
   [junit4]   2> 2423018 WARN  (jetty-launcher-7094-thread-1) [    ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@610f6628[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2423023 INFO  (jetty-launcher-7094-thread-2) [    ] o.e.j.s.AbstractConnector Started ServerConnector@7f5f902d{SSL,[ssl, http/1.1]}{127.0.0.1:35959}
   [junit4]   2> 2423023 INFO  (jetty-launcher-7094-thread-2) [    ] o.e.j.s.Server Started @2423069ms
   [junit4]   2> 2423023 INFO  (jetty-launcher-7094-thread-2) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=35959}
   [junit4]   2> 2423024 ERROR (jetty-launcher-7094-thread-2) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 2423024 INFO  (jetty-launcher-7094-thread-2) [    ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2423024 INFO  (jetty-launcher-7094-thread-2) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.1.0
   [junit4]   2> 2423024 INFO  (jetty-launcher-7094-thread-2) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2423024 INFO  (jetty-launcher-7094-thread-2) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2423024 INFO  (jetty-launcher-7094-thread-2) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2019-05-04T22:41:17.281Z
   [junit4]   2> 2423041 INFO  (jetty-launcher-7094-thread-1) [    ] o.e.j.s.AbstractConnector Started ServerConnector@345b1a0{SSL,[ssl, http/1.1]}{127.0.0.1:42201}
   [junit4]   2> 2423041 INFO  (jetty-launcher-7094-thread-1) [    ] o.e.j.s.Server Started @2423087ms
   [junit4]   2> 2423041 INFO  (jetty-launcher-7094-thread-1) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=42201}
   [junit4]   2> 2423042 ERROR (jetty-launcher-7094-thread-1) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 2423042 INFO  (jetty-launcher-7094-thread-1) [    ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2423042 INFO  (jetty-launcher-7094-thread-1) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.1.0
   [junit4]   2> 2423042 INFO  (jetty-launcher-7094-thread-1) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2423042 INFO  (jetty-launcher-7094-thread-1) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2423042 INFO  (jetty-launcher-7094-thread-1) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2019-05-04T22:41:17.299Z
   [junit4]   2> 2423062 INFO  (zkConnectionManagerCallback-7096-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2423071 INFO  (jetty-launcher-7094-thread-2) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2423082 INFO  (zkConnectionManagerCallback-7098-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2423083 INFO  (jetty-launcher-7094-thread-1) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2424110 INFO  (jetty-launcher-7094-thread-1) [    ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 2424111 WARN  (jetty-launcher-7094-thread-1) [    ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 2424124 WARN  (jetty-launcher-7094-thread-1) [    ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@7aa68298[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2424126 WARN  (jetty-launcher-7094-thread-1) [    ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 2424126 WARN  (jetty-launcher-7094-thread-1) [    ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@67967275[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2424142 INFO  (jetty-launcher-7094-thread-2) [    ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 2424144 INFO  (jetty-launcher-7094-thread-1) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39674/solr
   [junit4]   2> 2424161 WARN  (jetty-launcher-7094-thread-2) [    ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 2424196 INFO  (zkConnectionManagerCallback-7106-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2424241 WARN  (jetty-launcher-7094-thread-2) [    ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@438b23e2[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2424257 WARN  (jetty-launcher-7094-thread-2) [    ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 2424258 WARN  (jetty-launcher-7094-thread-2) [    ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@6a3068c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2424259 INFO  (jetty-launcher-7094-thread-2) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39674/solr
   [junit4]   2> 2424290 INFO  (zkConnectionManagerCallback-7114-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2424342 INFO  (zkConnectionManagerCallback-7109-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2424378 INFO  (zkConnectionManagerCallback-7116-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2424658 INFO  (jetty-launcher-7094-thread-2) [n:127.0.0.1:35959_solr    ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:35959_solr
   [junit4]   2> 2424695 INFO  (jetty-launcher-7094-thread-2) [n:127.0.0.1:35959_solr    ] o.a.s.c.Overseer Overseer (id=74636244126138376-127.0.0.1:35959_solr-n_0000000000) starting
   [junit4]   2> 2425031 INFO  (zkConnectionManagerCallback-7125-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2425053 INFO  (jetty-launcher-7094-thread-2) [n:127.0.0.1:35959_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:39674/solr ready
   [junit4]   2> 2425081 INFO  (OverseerStateUpdate-74636244126138376-127.0.0.1:35959_solr-n_0000000000) [n:127.0.0.1:35959_solr    ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:35959_solr
   [junit4]   2> 2425128 INFO  (jetty-launcher-7094-thread-2) [n:127.0.0.1:35959_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:35959_solr
   [junit4]   2> 2425191 INFO  (jetty-launcher-7094-thread-1) [n:127.0.0.1:42201_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 2425193 INFO  (jetty-launcher-7094-thread-1) [n:127.0.0.1:42201_solr    ] o.a.s.c.ZkController Publish node=127.0.0.1:42201_solr as DOWN
   [junit4]   2> 2425242 INFO  (zkCallback-7115-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 2425286 INFO  (zkCallback-7124-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 2425299 INFO  (jetty-launcher-7094-thread-1) [n:127.0.0.1:42201_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 2425299 INFO  (jetty-launcher-7094-thread-1) [n:127.0.0.1:42201_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:42201_solr
   [junit4]   2> 2425322 INFO  (zkCallback-7124-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2425343 INFO  (zkCallback-7115-thread-2) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2425415 INFO  (zkCallback-7108-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2425433 INFO  (zkConnectionManagerCallback-7130-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2425434 INFO  (jetty-launcher-7094-thread-1) [n:127.0.0.1:42201_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 2425434 INFO  (jetty-launcher-7094-thread-1) [n:127.0.0.1:42201_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:39674/solr ready
   [junit4]   2> 2425435 INFO  (jetty-launcher-7094-thread-1) [n:127.0.0.1:42201_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 2425456 INFO  (jetty-launcher-7094-thread-2) [n:127.0.0.1:35959_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 2426035 INFO  (jetty-launcher-7094-thread-2) [n:127.0.0.1:35959_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35959.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@436b0bcb
   [junit4]   2> 2426062 INFO  (jetty-launcher-7094-thread-1) [n:127.0.0.1:42201_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42201.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@436b0bcb
   [junit4]   2> 2426098 INFO  (jetty-launcher-7094-thread-1) [n:127.0.0.1:42201_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42201.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@436b0bcb
   [junit4]   2> 2426098 INFO  (jetty-launcher-7094-thread-1) [n:127.0.0.1:42201_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42201.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@436b0bcb
   [junit4]   2> 2426099 INFO  (jetty-launcher-7094-thread-1) [n:127.0.0.1:42201_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.cloud.ReindexCollectionTest_6995F41A2F5188AB-001/tempDir-001/node1/.
   [junit4]   2> 2426134 INFO  (jetty-launcher-7094-thread-2) [n:127.0.0.1:35959_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35959.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@436b0bcb
   [junit4]   2> 2426134 INFO  (jetty-launcher-7094-thread-2) [n:127.0.0.1:35959_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35959.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@436b0bcb
   [junit4]   2> 2426135 INFO  (jetty-launcher-7094-thread-2) [n:127.0.0.1:35959_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.cloud.ReindexCollectionTest_6995F41A2F5188AB-001/tempDir-001/node2/.
   [junit4]   2> 2426449 INFO  (zkConnectionManagerCallback-7137-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2426501 INFO  (SUITE-ReindexCollectionTest-seed#[6995F41A2F5188AB]-worker) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 2426503 INFO  (SUITE-ReindexCollectionTest-seed#[6995F41A2F5188AB]-worker) [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:39674/solr ready
   [junit4]   2> 2427821 INFO  (TEST-ReindexCollectionTest.testFailure-seed#[6995F41A2F5188AB]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testFailure
   [junit4]   2> 2427836 INFO  (zkConnectionManagerCallback-7142-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2427837 INFO  (TEST-ReindexCollectionTest.testFailure-seed#[6995F41A2F5188AB]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 2427837 INFO  (TEST-ReindexCollectionTest.testFailure-seed#[6995F41A2F5188AB]) [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:39674/solr ready
   [junit4]   2> 2427973 INFO  (qtp1174835224-20622) [n:127.0.0.1:35959_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf1&maxShardsPerNode=-1&name=failReindexing&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 2428106 INFO  (OverseerThreadFactory-5781-thread-1-processing-n:127.0.0.1:35959_solr) [n:127.0.0.1:35959_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection failReindexing
   [junit4]   2> 2428331 INFO  (OverseerStateUpdate-74636244126138376-127.0.0.1:35959_solr-n_0000000000) [n:127.0.0.1:35959_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"failReindexing",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"failReindexing_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:35959/solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2428350 INFO  (OverseerStateUpdate-74636244126138376-127.0.0.1:35959_solr-n_0000000000) [n:127.0.0.1:35959_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"failReindexing",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"failReindexing_shard1_replica_n3",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:42201/solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2428352 INFO  (OverseerStateUpdate-74636244126138376-127.0.0.1:35959_solr-n_0000000000) [n:127.0.0.1:35959_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"failReindexing",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"failReindexing_shard2_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:35959/solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2428367 INFO  (OverseerStateUpdate-74636244126138376-127.0.0.1:35959_solr-n_0000000000) [n:127.0.0.1:35959_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"failReindexing",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"failReindexing_shard2_replica_n6",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:42201/solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2428608 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr    x:failReindexing_shard2_replica_n4] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf1&newCollection=true&name=failReindexing_shard2_replica_n4&action=CREATE&numShards=2&collection=failReindexing&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2428610 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr    x:failReindexing_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf1&newCollection=true&name=failReindexing_shard1_replica_n1&action=CREATE&numShards=2&collection=failReindexing&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2428610 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr    x:failReindexing_shard1_replica_n1] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 2428721 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr    x:failReindexing_shard1_replica_n3] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf1&newCollection=true&name=failReindexing_shard1_replica_n3&action=CREATE&numShards=2&collection=failReindexing&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2428744 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr    x:failReindexing_shard2_replica_n6] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf1&newCollection=true&name=failReindexing_shard2_replica_n6&action=CREATE&numShards=2&collection=failReindexing&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2430129 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
   [junit4]   2> 2430170 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
   [junit4]   2> 2430174 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
   [junit4]   2> 2430209 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.s.IndexSchema [failReindexing_shard2_replica_n6] Schema name=minimal
   [junit4]   2> 2430212 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2430212 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.c.CoreContainer Creating SolrCore 'failReindexing_shard2_replica_n6' using configuration from collection failReindexing, trusted=true
   [junit4]   2> 2430230 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.s.IndexSchema [failReindexing_shard2_replica_n4] Schema name=minimal
   [junit4]   2> 2430240 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42201.solr.core.failReindexing.shard2.replica_n6' (registry 'solr.core.failReindexing.shard2.replica_n6') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@436b0bcb
   [junit4]   2> 2430241 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.c.SolrCore [[failReindexing_shard2_replica_n6] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.cloud.ReindexCollectionTest_6995F41A2F5188AB-001/tempDir-001/node1/failReindexing_shard2_replica_n6], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.cloud.ReindexCollectionTest_6995F41A2F5188AB-001/tempDir-001/node1/./failReindexing_shard2_replica_n6/data/]
   [junit4]   2> 2430249 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
   [junit4]   2> 2430578 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2430578 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.c.CoreContainer Creating SolrCore 'failReindexing_shard2_replica_n4' using configuration from collection failReindexing, trusted=true
   [junit4]   2> 2430579 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35959.solr.core.failReindexing.shard2.replica_n4' (registry 'solr.core.failReindexing.shard2.replica_n4') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@436b0bcb
   [junit4]   2> 2430579 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.c.SolrCore [[failReindexing_shard2_replica_n4] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.cloud.ReindexCollectionTest_6995F41A2F5188AB-001/tempDir-001/node2/failReindexing_shard2_replica_n4], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.cloud.ReindexCollectionTest_6995F41A2F5188AB-001/tempDir-001/node2/./failReindexing_shard2_replica_n4/data/]
   [junit4]   2> 2430622 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.s.IndexSchema [failReindexing_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 2430624 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2430624 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'failReindexing_shard1_replica_n1' using configuration from collection failReindexing, trusted=true
   [junit4]   2> 2430625 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35959.solr.core.failReindexing.shard1.replica_n1' (registry 'solr.core.failReindexing.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@436b0bcb
   [junit4]   2> 2430625 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.c.SolrCore [[failReindexing_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.cloud.ReindexCollectionTest_6995F41A2F5188AB-001/tempDir-001/node2/failReindexing_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.cloud.ReindexCollectionTest_6995F41A2F5188AB-001/tempDir-001/node2/./failReindexing_shard1_replica_n1/data/]
   [junit4]   2> 2430630 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.s.IndexSchema [failReindexing_shard1_replica_n3] Schema name=minimal
   [junit4]   2> 2430632 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2430632 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.c.CoreContainer Creating SolrCore 'failReindexing_shard1_replica_n3' using configuration from collection failReindexing, trusted=true
   [junit4]   2> 2430632 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42201.solr.core.failReindexing.shard1.replica_n3' (registry 'solr.core.failReindexing.shard1.replica_n3') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@436b0bcb
   [junit4]   2> 2430632 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.c.SolrCore [[failReindexing_shard1_replica_n3] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.cloud.ReindexCollectionTest_6995F41A2F5188AB-001/tempDir-001/node1/failReindexing_shard1_replica_n3], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.cloud.ReindexCollectionTest_6995F41A2F5188AB-001/tempDir-001/node1/./failReindexing_shard1_replica_n3/data/]
   [junit4]   2> 2431311 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2431311 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2431312 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2431312 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2431313 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.s.SolrIndexSearcher Opening [Searcher@1188e180[failReindexing_shard2_replica_n6] main]
   [junit4]   2> 2431326 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2431326 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2431327 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2431327 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2431328 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.s.SolrIndexSearcher Opening [Searcher@66406b6c[failReindexing_shard1_replica_n3] main]
   [junit4]   2> 2431342 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 2431363 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2431363 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2431363 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1632642988108677120
   [junit4]   2> 2431367 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 2431368 INFO  (searcherExecutor-5790-thread-1-processing-n:127.0.0.1:42201_solr x:failReindexing_shard2_replica_n6 c:failReindexing s:shard2 r:core_node8) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.c.SolrCore [failReindexing_shard2_replica_n6] Registered new searcher Searcher@1188e180[failReindexing_shard2_replica_n6] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2431368 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2431368 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2431368 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1632642988113920000
   [junit4]   2> 2431385 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.c.ZkShardTerms Successful update of terms at /collections/failReindexing/terms/shard2 to Terms{values={core_node8=0}, version=0}
   [junit4]   2> 2431385 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/failReindexing/leaders/shard2
   [junit4]   2> 2431399 INFO  (searcherExecutor-5793-thread-1-processing-n:127.0.0.1:42201_solr x:failReindexing_shard1_replica_n3 c:failReindexing s:shard1 r:core_node5) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.c.SolrCore [failReindexing_shard1_replica_n3] Registered new searcher Searcher@66406b6c[failReindexing_shard1_replica_n3] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2431420 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.c.ZkShardTerms Successful update of terms at /collections/failReindexing/terms/shard1 to Terms{values={core_node5=0}, version=0}
   [junit4]   2> 2431420 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/failReindexing/leaders/shard1
   [junit4]   2> 2431423 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard1: total=2 found=1 timeoutin=9999ms
   [junit4]   2> 2431522 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard2: total=2 found=1 timeoutin=9999ms
   [junit4]   2> 2431525 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2431525 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2431526 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2431526 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2431527 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@603f2b01[failReindexing_shard1_replica_n1] main]
   [junit4]   2> 2431528 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2431528 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2431535 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 2431535 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2431535 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2431535 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1632642988289032192
   [junit4]   2> 2431545 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2431545 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2431551 INFO  (searcherExecutor-5792-thread-1-processing-n:127.0.0.1:35959_solr x:failReindexing_shard1_replica_n1 c:failReindexing s:shard1 r:core_node2) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.c.SolrCore [failReindexing_shard1_replica_n1] Registered new searcher Searcher@603f2b01[failReindexing_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2431561 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.s.SolrIndexSearcher Opening [Searcher@6b806ac5[failReindexing_shard2_replica_n4] main]
   [junit4]   2> 2431570 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at /collections/failReindexing/terms/shard1 to Terms{values={core_node2=0, core_node5=0}, version=1}
   [junit4]   2> 2431570 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/failReindexing/leaders/shard1
   [junit4]   2> 2431574 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 2431574 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2431574 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2431574 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1632642988329926656
   [junit4]   2> 2431688 INFO  (zkCallback-7115-thread-2) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/failReindexing/state.json] for collection [failReindexing] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2431690 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.c.ZkShardTerms Successful update of terms at /collections/failReindexing/terms/shard2 to Terms{values={core_node7=0, core_node8=0}, version=1}
   [junit4]   2> 2431690 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/failReindexing/leaders/shard2
   [junit4]   2> 2431692 INFO  (searcherExecutor-5791-thread-1-processing-n:127.0.0.1:35959_solr x:failReindexing_shard2_replica_n4 c:failReindexing s:shard2 r:core_node7) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.c.SolrCore [failReindexing_shard2_replica_n4] Registered new searcher Searcher@6b806ac5[failReindexing_shard2_replica_n4] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2431987 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2431987 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 2431987 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:42201/solr/failReindexing_shard1_replica_n3/
   [junit4]   2> 2431998 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.u.PeerSync PeerSync: core=failReindexing_shard1_replica_n3 url=https://127.0.0.1:42201/solr START replicas=[https://127.0.0.1:35959/solr/failReindexing_shard1_replica_n1/] nUpdates=100
   [junit4]   2> 2431998 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.u.PeerSync PeerSync: core=failReindexing_shard1_replica_n3 url=https://127.0.0.1:42201/solr DONE.  We have no versions.  sync failed.
   [junit4]   2> 2432018 INFO  (qtp1174835224-20621) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.c.S.Request [failReindexing_shard1_replica_n1]  webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 2432031 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 2432031 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] 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> 2432031 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/failReindexing/leaders/shard1/leader after winning as /collections/failReindexing/leader_elect/shard1/election/74636244126138375-core_node5-n_0000000000
   [junit4]   2> 2432050 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:42201/solr/failReindexing_shard1_replica_n3/ shard1
   [junit4]   2> 2432064 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2432064 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 2432064 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:42201/solr/failReindexing_shard2_replica_n6/
   [junit4]   2> 2432064 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.u.PeerSync PeerSync: core=failReindexing_shard2_replica_n6 url=https://127.0.0.1:42201/solr START replicas=[https://127.0.0.1:35959/solr/failReindexing_shard2_replica_n4/] nUpdates=100
   [junit4]   2> 2432064 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.u.PeerSync PeerSync: core=failReindexing_shard2_replica_n6 url=https://127.0.0.1:42201/solr DONE.  We have no versions.  sync failed.
   [junit4]   2> 2432084 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.c.S.Request [failReindexing_shard2_replica_n4]  webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=19
   [junit4]   2> 2432085 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 2432085 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] 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> 2432085 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/failReindexing/leaders/shard2/leader after winning as /collections/failReindexing/leader_elect/shard2/election/74636244126138375-core_node8-n_0000000000
   [junit4]   2> 2432086 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:42201/solr/failReindexing_shard2_replica_n6/ shard2
   [junit4]   2> 2432282 INFO  (zkCallback-7108-thread-2) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/failReindexing/state.json] for collection [failReindexing] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2432304 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 2432305 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf1&newCollection=true&name=failReindexing_shard2_replica_n6&action=CREATE&numShards=2&collection=failReindexing&shard=shard2&wt=javabin&version=2&replicaType=NRT} status=0 QTime=3561
   [junit4]   2> 2432311 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 2432368 INFO  (qtp1134636168-20624) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf1&newCollection=true&name=failReindexing_shard1_replica_n3&action=CREATE&numShards=2&collection=failReindexing&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=3647
   [junit4]   2> 2432509 INFO  (zkCallback-7108-thread-1) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/failReindexing/state.json] for collection [failReindexing] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2432521 INFO  (zkCallback-7108-thread-2) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/failReindexing/state.json] for collection [failReindexing] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2432846 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf1&newCollection=true&name=failReindexing_shard1_replica_n1&action=CREATE&numShards=2&collection=failReindexing&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=4236
   [junit4]   2> 2432930 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf1&newCollection=true&name=failReindexing_shard2_replica_n4&action=CREATE&numShards=2&collection=failReindexing&shard=shard2&wt=javabin&version=2&replicaType=NRT} status=0 QTime=4322
   [junit4]   2> 2433028 INFO  (qtp1174835224-20622) [n:127.0.0.1:35959_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> 2433137 INFO  (zkCallback-7108-thread-1) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/failReindexing/state.json] for collection [failReindexing] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2433137 INFO  (zkCallback-7115-thread-1) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/failReindexing/state.json] for collection [failReindexing] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2433137 INFO  (zkCallback-7108-thread-2) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/failReindexing/state.json] for collection [failReindexing] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2433137 INFO  (zkCallback-7115-thread-3) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/failReindexing/state.json] for collection [failReindexing] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2433178 INFO  (qtp1174835224-20622) [n:127.0.0.1:35959_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf1&maxShardsPerNode=-1&name=failReindexing&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2} status=0 QTime=5205
   [junit4]   2> 2433304 INFO  (qtp1174835224-20621) [n:127.0.0.1:35959_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf1&maxShardsPerNode=-1&name=failReindexingTarget&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 2433364 INFO  (OverseerThreadFactory-5781-thread-2-processing-n:127.0.0.1:35959_solr) [n:127.0.0.1:35959_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection failReindexingTarget
   [junit4]   2> 2433381 INFO  (OverseerCollectionConfigSetProcessor-74636244126138376-127.0.0.1:35959_solr-n_0000000000) [n:127.0.0.1:35959_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may have disconnected from ZooKeeper
   [junit4]   2> 2433652 INFO  (OverseerStateUpdate-74636244126138376-127.0.0.1:35959_solr-n_0000000000) [n:127.0.0.1:35959_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"failReindexingTarget",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"failReindexingTarget_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:35959/solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2433856 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr    x:failReindexingTarget_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf1&newCollection=true&name=failReindexingTarget_shard1_replica_n1&action=CREATE&numShards=1&collection=failReindexingTarget&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2435088 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
   [junit4]   2> 2435145 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.s.IndexSchema [failReindexingTarget_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 2435179 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2435180 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'failReindexingTarget_shard1_replica_n1' using configuration from collection failReindexingTarget, trusted=true
   [junit4]   2> 2435180 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35959.solr.core.failReindexingTarget.shard1.replica_n1' (registry 'solr.core.failReindexingTarget.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@436b0bcb
   [junit4]   2> 2435180 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.c.SolrCore [[failReindexingTarget_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.cloud.ReindexCollectionTest_6995F41A2F5188AB-001/tempDir-001/node2/failReindexingTarget_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/build/solr-core/test/J0/temp/solr.cloud.ReindexCollectionTest_6995F41A2F5188AB-001/tempDir-001/node2/./failReindexingTarget_shard1_replica_n1/data/]
   [junit4]   2> 2435588 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2435588 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2435589 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2435589 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2435590 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@209674af[failReindexingTarget_shard1_replica_n1] main]
   [junit4]   2> 2435591 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 2435592 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2435625 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2435625 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1632642992577708032
   [junit4]   2> 2435627 INFO  (searcherExecutor-5810-thread-1-processing-n:127.0.0.1:35959_solr x:failReindexingTarget_shard1_replica_n1 c:failReindexingTarget s:shard1 r:core_node2) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.c.SolrCore [failReindexingTarget_shard1_replica_n1] Registered new searcher Searcher@209674af[failReindexingTarget_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2435642 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at /collections/failReindexingTarget/terms/shard1 to Terms{values={core_node2=0}, version=0}
   [junit4]   2> 2435642 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/failReindexingTarget/leaders/shard1
   [junit4]   2> 2435645 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2435661 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 2435661 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:35959/solr/failReindexingTarget_shard1_replica_n1/
   [junit4]   2> 2435661 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 2435661 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.c.SyncStrategy https://127.0.0.1:35959/solr/failReindexingTarget_shard1_replica_n1/ has no replicas
   [junit4]   2> 2435661 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/failReindexingTarget/leaders/shard1/leader after winning as /collections/failReindexingTarget/leader_elect/shard1/election/74636244126138376-core_node2-n_0000000000
   [junit4]   2> 2435662 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:35959/solr/failReindexingTarget_shard1_replica_n1/ shard1
   [junit4]   2> 2435912 INFO  (zkCallback-7115-thread-3) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/failReindexingTarget/state.json] for collection [failReindexingTarget] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2435912 INFO  (zkCallback-7115-thread-1) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/failReindexingTarget/state.json] for collection [failReindexingTarget] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2435916 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 2435969 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexingTarget s:shard1 r:core_node2 x:failReindexingTarget_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf1&newCollection=true&name=failReindexingTarget_shard1_replica_n1&action=CREATE&numShards=1&collection=failReindexingTarget&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=2113
   [junit4]   2> 2435972 INFO  (qtp1174835224-20621) [n:127.0.0.1:35959_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> 2436058 INFO  (zkCallback-7115-thread-1) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/failReindexingTarget/state.json] for collection [failReindexingTarget] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2436059 INFO  (zkCallback-7115-thread-3) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/failReindexingTarget/state.json] for collection [failReindexingTarget] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2436059 INFO  (zkCallback-7115-thread-2) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/failReindexingTarget/state.json] for collection [failReindexingTarget] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 2436059 INFO  (qtp1174835224-20621) [n:127.0.0.1:35959_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf1&maxShardsPerNode=-1&name=failReindexingTarget&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2} status=0 QTime=2754
   [junit4]   2> 2436062 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :createalias with params collections=failReindexingTarget&name=failAlias&action=CREATEALIAS&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 2436224 INFO  (OverseerCollectionConfigSetProcessor-74636244126138376-127.0.0.1:35959_solr-n_0000000000) [n:127.0.0.1:35959_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000002 doesn't exist.  Requestor may have disconnected from ZooKeeper
   [junit4]   2> 2436387 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collections=failReindexingTarget&name=failAlias&action=CREATEALIAS&wt=javabin&version=2} status=0 QTime=325
   [junit4]   2> 2436532 INFO  (qtp1134636168-20628) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.c.ZkShardTerms Successful update of terms at /collections/failReindexing/terms/shard2 to Terms{values={core_node7=1, core_node8=1}, version=2}
   [junit4]   2> 2437722 INFO  (qtp1134636168-20626) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.c.ZkShardTerms Successful update of terms at /collections/failReindexing/terms/shard1 to Terms{values={core_node2=1, core_node5=1}, version=2}
   [junit4]   2> 2437760 INFO  (qtp1174835224-20621) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [failReindexing_shard1_replica_n1]  webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:42201/solr/failReindexing_shard1_replica_n3/&wt=javabin&version=2}{add=[0 (1632642993509892096), 1 (1632642994060394496), 4 (1632642994060394497), 8 (1632642994060394498), 10 (1632642994060394499), 11 (1632642994060394500), 12 (1632642994060394501), 13 (1632642994060394502), 14 (1632642994060394503), 15 (1632642994060394504), ... (103 adds)]} 0 76
   [junit4]   2> 2437773 INFO  (qtp1174835224-20619) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.u.p.LogUpdateProcessorFactory [failReindexing_shard2_replica_n4]  webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:42201/solr/failReindexing_shard2_replica_n6/&wt=javabin&version=2}{add=[2 (1632642993410277376), 3 (1632642993491017728), 5 (1632642993491017729), 6 (1632642993491017730), 7 (1632642993491017731), 9 (1632642993491017732), 17 (1632642993491017733), 18 (1632642993491017734), 19 (1632642993491017735), 21 (1632642993491017736), ... (97 adds)]} 0 124
   [junit4]   2> 2437809 INFO  (qtp1134636168-20628) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.u.p.LogUpdateProcessorFactory [failReindexing_shard2_replica_n6]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[2 (1632642993410277376), 3 (1632642993491017728), 5 (1632642993491017729), 6 (1632642993491017730), 7 (1632642993491017731), 9 (1632642993491017732), 17 (1632642993491017733), 18 (1632642993491017734), 19 (1632642993491017735), 21 (1632642993491017736), ... (97 adds)]} 0 1389
   [junit4]   2> 2437841 ERROR (updateExecutor-7102-thread-2-processing-x:failReindexing_shard1_replica_n3 r:core_node5 null n:127.0.0.1:42201_solr c:failReindexing s:shard1) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.c.s.i.ConcurrentUpdateHttp2SolrClient Error consuming and closing http response stream.
   [junit4]   2>           => java.nio.channels.AsynchronousCloseException
   [junit4]   2> 	at org.eclipse.jetty.client.util.InputStreamResponseListener$Input.read(InputStreamResponseListener.java:316)
   [junit4]   2> java.nio.channels.AsynchronousCloseException: null
   [junit4]   2> 	at org.eclipse.jetty.client.util.InputStreamResponseListener$Input.read(InputStreamResponseListener.java:316) ~[jetty-client-9.4.14.v20181114.jar:9.4.14.v20181114]
   [junit4]   2> 	at java.io.InputStream.read(InputStream.java:101) ~[?:1.8.0_191]
   [junit4]   2> 	at org.eclipse.jetty.client.util.InputStreamResponseListener$Input.read(InputStreamResponseListener.java:287) ~[jetty-client-9.4.14.v20181114.jar:9.4.14.v20181114]
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClient$Runner.sendUpdateStream(ConcurrentUpdateHttp2SolrClient.java:283) ~[java/:?]
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.ConcurrentUpdateHttp2SolrClient$Runner.run(ConcurrentUpdateHttp2SolrClient.java:176) ~[java/:?]
   [junit4]   2> 	at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:181) ~[metrics-core-4.0.5.jar:4.0.5]
   [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:1149) ~[?:1.8.0_191]
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) ~[?:1.8.0_191]
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748) [?:1.8.0_191]
   [junit4]   2> 2437845 INFO  (qtp1134636168-20626) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.u.p.LogUpdateProcessorFactory [failReindexing_shard1_replica_n3]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[0 (1632642993509892096), 1 (1632642994060394496), 4 (1632642994060394497), 8 (1632642994060394498), 10 (1632642994060394499), 11 (1632642994060394500), 12 (1632642994060394501), 13 (1632642994060394502), 14 (1632642994060394503), 15 (1632642994060394504), ... (103 adds)]} 0 1331
   [junit4]   2> 2438405 INFO  (OverseerCollectionConfigSetProcessor-74636244126138376-127.0.0.1:35959_solr-n_0000000000) [n:127.0.0.1:35959_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000004 doesn't exist.  Requestor may have disconnected from ZooKeeper
   [junit4]   2> 2438426 INFO  (qtp1134636168-20626) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1632642995514769408,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2438426 INFO  (qtp1134636168-20626) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@421f750d commitCommandVersion:1632642995514769408
   [junit4]   2> 2438623 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1632642995721338880,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2438623 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@31ec1663 commitCommandVersion:1632642995721338880
   [junit4]   2> 2438880 INFO  (qtp1134636168-20626) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.s.SolrIndexSearcher Opening [Searcher@5303ea06[failReindexing_shard1_replica_n3] main]
   [junit4]   2> 2438881 INFO  (qtp1134636168-20626) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2438882 INFO  (searcherExecutor-5793-thread-1-processing-n:127.0.0.1:42201_solr x:failReindexing_shard1_replica_n3 c:failReindexing s:shard1 r:core_node5) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.c.SolrCore [failReindexing_shard1_replica_n3] Registered new searcher Searcher@5303ea06[failReindexing_shard1_replica_n3] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C103:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-112-generic, timestamp=1557009692720}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 2438899 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1ebcbd82[failReindexing_shard1_replica_n1] main]
   [junit4]   2> 2438899 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2438915 INFO  (searcherExecutor-5792-thread-1-processing-n:127.0.0.1:35959_solr x:failReindexing_shard1_replica_n1 c:failReindexing s:shard1 r:core_node2) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.c.SolrCore [failReindexing_shard1_replica_n1] Registered new searcher Searcher@1ebcbd82[failReindexing_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C103:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-112-generic, timestamp=1557009692883}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 2439061 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [failReindexing_shard1_replica_n1]  webapp=/solr path=/update params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:42201/solr/failReindexing_shard1_replica_n3/&commit_end_point=replicas&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 437
   [junit4]   2> 2439105 INFO  (qtp1134636168-20626) [n:127.0.0.1:42201_solr c:failReindexing s:shard1 r:core_node5 x:failReindexing_shard1_replica_n3] o.a.s.u.p.LogUpdateProcessorFactory [failReindexing_shard1_replica_n3]  webapp=/solr path=/update params={update.distrib=TOLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:42201/solr/failReindexing_shard2_replica_n6/&commit_end_point=leaders&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 679
   [junit4]   2> 2439170 INFO  (qtp1134636168-20625) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1632642996294909952,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2439170 INFO  (qtp1134636168-20625) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@71f61411 commitCommandVersion:1632642996294909952
   [junit4]   2> 2439194 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1632642996320075776,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2439194 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2ecc7b1d commitCommandVersion:1632642996320075776
   [junit4]   2> 2439305 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.s.SolrIndexSearcher Opening [Searcher@68fa1e36[failReindexing_shard2_replica_n4] main]
   [junit4]   2> 2439305 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2439398 INFO  (searcherExecutor-5791-thread-1-processing-n:127.0.0.1:35959_solr x:failReindexing_shard2_replica_n4 c:failReindexing s:shard2 r:core_node7) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.c.SolrCore [failReindexing_shard2_replica_n4] Registered new searcher Searcher@68fa1e36[failReindexing_shard2_replica_n4] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C97:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-112-generic, timestamp=1557009693561}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 2439453 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard2 r:core_node7 x:failReindexing_shard2_replica_n4] o.a.s.u.p.LogUpdateProcessorFactory [failReindexing_shard2_replica_n4]  webapp=/solr path=/update params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:42201/solr/failReindexing_shard2_replica_n6/&commit_end_point=replicas&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 259
   [junit4]   2> 2439455 INFO  (qtp1134636168-20625) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.s.SolrIndexSearcher Opening [Searcher@47a7fa0c[failReindexing_shard2_replica_n6] main]
   [junit4]   2> 2439455 INFO  (qtp1134636168-20625) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2439465 INFO  (searcherExecutor-5790-thread-1-processing-n:127.0.0.1:42201_solr x:failReindexing_shard2_replica_n6 c:failReindexing s:shard2 r:core_node8) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.c.SolrCore [failReindexing_shard2_replica_n6] Registered new searcher Searcher@47a7fa0c[failReindexing_shard2_replica_n6] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C97:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-112-generic, timestamp=1557009693561}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 2439466 INFO  (qtp1134636168-20625) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.u.p.LogUpdateProcessorFactory [failReindexing_shard2_replica_n6]  webapp=/solr path=/update params={_stateVer_=failReindexing:7&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 1490
   [junit4]   2> 2439830 INFO  (qtp1174835224-20620) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.c.S.Request [failReindexing_shard1_replica_n1]  webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=failReindexing:7&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=https://127.0.0.1:35959/solr/failReindexing_shard1_replica_n1/|https://127.0.0.1:42201/solr/failReindexing_shard1_replica_n3/&rows=10&version=2&q=*:*&NOW=1557009693723&isShard=true&wt=javabin} hits=103 status=0 QTime=0
   [junit4]   2> 2439832 INFO  (qtp1134636168-20625) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.c.S.Request [failReindexing_shard2_replica_n6]  webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=failReindexing:7&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=https://127.0.0.1:42201/solr/failReindexing_shard2_replica_n6/|https://127.0.0.1:35959/solr/failReindexing_shard2_replica_n4/&rows=10&version=2&q=*:*&NOW=1557009693723&isShard=true&wt=javabin} hits=97 status=0 QTime=0
   [junit4]   2> 2439906 INFO  (qtp1174835224-20618) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.c.S.Request [failReindexing_shard1_replica_n1]  webapp=/solr path=/select params={q=*:*&df=text&distrib=false&_stateVer_=failReindexing:7&shards.purpose=64&NOW=1557009693723&ids=11,0,12,1,13,14,15,4,8,10&isShard=true&shard.url=https://127.0.0.1:35959/solr/failReindexing_shard1_replica_n1/|https://127.0.0.1:42201/solr/failReindexing_shard1_replica_n3/&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 2439919 INFO  (qtp1134636168-20627) [n:127.0.0.1:42201_solr c:failReindexing s:shard2 r:core_node8 x:failReindexing_shard2_replica_n6] o.a.s.c.S.Request [failReindexing_shard2_replica_n6]  webapp=/solr path=/select params={q=*:*&_stateVer_=failReindexing:7&wt=javabin&version=2} hits=200 status=0 QTime=452
   [junit4]   2> 2439939 INFO  (qtp1174835224-20622) [n:127.0.0.1:35959_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :reindexcollection with params name=failReindexing&action=REINDEXCOLLECTION&wt=javabin&version=2&target=failReindexingTarget and sendToOCPQueue=true
   [junit4]   2> 2439971 DEBUG (OverseerThreadFactory-5781-thread-4-processing-n:127.0.0.1:35959_solr) [n:127.0.0.1:35959_solr    ] o.a.s.c.a.c.ReindexCollectionCmd *** called: {
   [junit4]   2>   "name":"failReindexing",
   [junit4]   2>   "target":"failReindexingTarget",
   [junit4]   2>   "operation":"reindexcollection"}
   [junit4]   2> 2440064 INFO  (zkConnectionManagerCallback-7152-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2440065 INFO  (OverseerThreadFactory-5781-thread-4-processing-n:127.0.0.1:35959_solr) [n:127.0.0.1:35959_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 2440065 INFO  (OverseerThreadFactory-5781-thread-4-processing-n:127.0.0.1:35959_solr) [n:127.0.0.1:35959_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:39674/solr ready
   [junit4]   2> 2440883 INFO  (qtp1174835224-20621) [n:127.0.0.1:35959_solr c:failReindexing s:shard1 r:core_node2 x:failReindexing_shard1_replica_n1] o.a.s.c.S.Request [failReindexin

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

s :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/lucene/top-level-ivy-settings.xml

resolve:

jar-checksums:
    [mkdir] Created dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/null1113290540
     [copy] Copying 239 files to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/null1113290540
   [delete] Deleting directory /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.1/solr/null1113290540

check-working-copy:
[ivy:cachepath] :: resolving dependencies :: #;working@lucene2-us-west.apache.org
[ivy:cachepath] 	confs: [default]
[ivy:cachepath] 	found org.eclipse.jgit#org.eclipse.jgit;5.3.0.201903130848-r in public
[ivy:cachepath] 	found com.jcraft#jsch;0.1.54 in public
[ivy:cachepath] 	found com.jcraft#jzlib;1.1.1 in public
[ivy:cachepath] 	found com.googlecode.javaewah#JavaEWAH;1.1.6 in public
[ivy:cachepath] 	found org.slf4j#slf4j-api;1.7.2 in public
[ivy:cachepath] 	found org.bouncycastle#bcpg-jdk15on;1.60 in public
[ivy:cachepath] 	found org.bouncycastle#bcprov-jdk15on;1.60 in public
[ivy:cachepath] 	found org.bouncycastle#bcpkix-jdk15on;1.60 in public
[ivy:cachepath] 	found org.slf4j#slf4j-nop;1.7.2 in public
[ivy:cachepath] :: resolution report :: resolve 164ms :: artifacts dl 14ms
	---------------------------------------------------------------------
	|                  |            modules            ||   artifacts   |
	|       conf       | number| search|dwnlded|evicted|| number|dwnlded|
	---------------------------------------------------------------------
	|      default     |   9   |   0   |   0   |   0   ||   9   |   0   |
	---------------------------------------------------------------------
[wc-checker] Initializing working copy...
[wc-checker] Checking working copy status...

-jenkins-base:

BUILD SUCCESSFUL
Total time: 221 minutes 5 seconds
Archiving artifacts
java.lang.InterruptedException: no matches found within 10000
	at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:2847)
	at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2726)
	at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2707)
	at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3086)
Also:   hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene2
		at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1741)
		at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:357)
		at hudson.remoting.Channel.call(Channel.java:955)
		at hudson.FilePath.act(FilePath.java:1072)
		at hudson.FilePath.act(FilePath.java:1061)
		at hudson.FilePath.validateAntFileMask(FilePath.java:2705)
		at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
		at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
		at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
		at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
		at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
		at hudson.model.Build$BuildExecution.post2(Build.java:186)
		at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
		at hudson.model.Run.execute(Run.java:1835)
		at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
		at hudson.model.ResourceController.execute(ResourceController.java:97)
		at hudson.model.Executor.run(Executor.java:429)
Caused: hudson.FilePath$TunneledInterruptedException
	at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3088)
	at hudson.remoting.UserRequest.perform(UserRequest.java:212)
	at hudson.remoting.UserRequest.perform(UserRequest.java:54)
	at hudson.remoting.Request$2.run(Request.java:369)
	at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
	at java.lang.Thread.run(Thread.java:748)
Caused: java.lang.InterruptedException: java.lang.InterruptedException: no matches found within 10000
	at hudson.FilePath.act(FilePath.java:1074)
	at hudson.FilePath.act(FilePath.java:1061)
	at hudson.FilePath.validateAntFileMask(FilePath.java:2705)
	at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
	at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
	at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
	at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
	at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
	at hudson.model.Build$BuildExecution.post2(Build.java:186)
	at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
	at hudson.model.Run.execute(Run.java:1835)
	at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
	at hudson.model.ResourceController.execute(ResourceController.java:97)
	at hudson.model.Executor.run(Executor.java:429)
No artifacts found that match the file pattern "**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error?
Recording test results
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)

Mime
View raw message