Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.2-Windows/31/ Java: 32bit/jdk1.8.0_144 -client -XX:+UseSerialGC
1 tests failed. FAILED: junit.framework.TestSuite.org.apache.solr.cloud.TestPullReplicaErrorHandling Error Message: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper\server1\data\version-2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper\server1\data\version-2 C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper\server1\data: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper\server1\data C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper\server1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper\server1 C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001 Stack Trace: java.io.IOException: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper\server1\data\version-2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper\server1\data\version-2 C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper\server1\data: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper\server1\data C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper\server1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper\server1 C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001 at __randomizedtesting.SeedInfo.seed([1546513B510C22D5]:0) at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329) at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216) at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43) 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 13542 lines...] [junit4] Suite: org.apache.solr.cloud.TestPullReplicaErrorHandling [junit4] 2> 2900645 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\init-core-data-001 [junit4] 2> 2900647 WARN (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=243 numCloses=243 [junit4] 2> 2900647 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 2900653 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-5776) [junit4] 2> 2900655 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001 [junit4] 2> 2900656 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 2900656 INFO (Thread-5757) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 2900656 INFO (Thread-5757) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 2900660 ERROR (Thread-5757) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes [junit4] 2> 2900757 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:58223 [junit4] 2> 2900765 INFO (zkConnectionManagerCallback-7026-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2900777 INFO (jetty-launcher-7023-thread-4) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 2900777 INFO (jetty-launcher-7023-thread-1) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 2900777 INFO (jetty-launcher-7023-thread-3) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 2900777 INFO (jetty-launcher-7023-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@cfa124{/solr,null,AVAILABLE} [junit4] 2> 2900778 INFO (jetty-launcher-7023-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@68c53{/solr,null,AVAILABLE} [junit4] 2> 2900778 INFO (jetty-launcher-7023-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@912f16{HTTP/1.1,[http/1.1]}{127.0.0.1:58227} [junit4] 2> 2900778 INFO (jetty-launcher-7023-thread-4) [ ] o.e.j.s.Server Started @2908045ms [junit4] 2> 2900778 INFO (jetty-launcher-7023-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@17c5abb{HTTP/1.1,[http/1.1]}{127.0.0.1:58230} [junit4] 2> 2900778 INFO (jetty-launcher-7023-thread-3) [ ] o.e.j.s.Server Started @2908045ms [junit4] 2> 2900778 INFO (jetty-launcher-7023-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=58230} [junit4] 2> 2900779 ERROR (jetty-launcher-7023-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2900779 INFO (jetty-launcher-7023-thread-2) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 2900779 INFO (jetty-launcher-7023-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.2.1 [junit4] 2> 2900779 INFO (jetty-launcher-7023-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2900779 INFO (jetty-launcher-7023-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2900779 INFO (jetty-launcher-7023-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-01-09T12:08:06.467Z [junit4] 2> 2900778 INFO (jetty-launcher-7023-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=58227} [junit4] 2> 2900779 INFO (jetty-launcher-7023-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1ce052f{/solr,null,AVAILABLE} [junit4] 2> 2900779 ERROR (jetty-launcher-7023-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2900780 INFO (jetty-launcher-7023-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.2.1 [junit4] 2> 2900780 INFO (jetty-launcher-7023-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2900780 INFO (jetty-launcher-7023-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2900780 INFO (jetty-launcher-7023-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-01-09T12:08:06.468Z [junit4] 2> 2900780 INFO (jetty-launcher-7023-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6fa07c{HTTP/1.1,[http/1.1]}{127.0.0.1:58233} [junit4] 2> 2900780 INFO (jetty-launcher-7023-thread-2) [ ] o.e.j.s.Server Started @2908047ms [junit4] 2> 2900780 INFO (jetty-launcher-7023-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=58233} [junit4] 2> 2900780 ERROR (jetty-launcher-7023-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2900781 INFO (jetty-launcher-7023-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.2.1 [junit4] 2> 2900781 INFO (jetty-launcher-7023-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2900781 INFO (jetty-launcher-7023-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2900781 INFO (jetty-launcher-7023-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-01-09T12:08:06.469Z [junit4] 2> 2900782 INFO (jetty-launcher-7023-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@12039f2{/solr,null,AVAILABLE} [junit4] 2> 2900783 INFO (jetty-launcher-7023-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@ded964{HTTP/1.1,[http/1.1]}{127.0.0.1:58242} [junit4] 2> 2900783 INFO (jetty-launcher-7023-thread-1) [ ] o.e.j.s.Server Started @2908050ms [junit4] 2> 2900783 INFO (jetty-launcher-7023-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=58242} [junit4] 2> 2900783 ERROR (jetty-launcher-7023-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2900783 INFO (jetty-launcher-7023-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.2.1 [junit4] 2> 2900783 INFO (jetty-launcher-7023-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2900783 INFO (jetty-launcher-7023-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2900783 INFO (jetty-launcher-7023-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-01-09T12:08:06.471Z [junit4] 2> 2900789 INFO (zkConnectionManagerCallback-7028-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2900789 INFO (zkConnectionManagerCallback-7030-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2900789 INFO (zkConnectionManagerCallback-7034-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2900789 INFO (zkConnectionManagerCallback-7032-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2900789 INFO (jetty-launcher-7023-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2900789 INFO (jetty-launcher-7023-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2900790 INFO (jetty-launcher-7023-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2900790 INFO (jetty-launcher-7023-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2900808 INFO (jetty-launcher-7023-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58223/solr [junit4] 2> 2900809 INFO (jetty-launcher-7023-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58223/solr [junit4] 2> 2900809 INFO (jetty-launcher-7023-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58223/solr [junit4] 2> 2900811 INFO (zkConnectionManagerCallback-7040-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2900812 INFO (zkConnectionManagerCallback-7044-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2900813 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x160dad209cc0005, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> 2900813 INFO (zkConnectionManagerCallback-7046-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2900814 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x160dad209cc0006, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> 2900817 INFO (zkConnectionManagerCallback-7048-thread-1-processing-n:127.0.0.1:58242_solr) [n:127.0.0.1:58242_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2900818 INFO (zkConnectionManagerCallback-7050-thread-1-processing-n:127.0.0.1:58227_solr) [n:127.0.0.1:58227_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2900819 INFO (zkConnectionManagerCallback-7052-thread-1-processing-n:127.0.0.1:58233_solr) [n:127.0.0.1:58233_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2900823 INFO (jetty-launcher-7023-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58223/solr [junit4] 2> 2900828 INFO (zkConnectionManagerCallback-7056-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2900835 INFO (zkConnectionManagerCallback-7058-thread-1-processing-n:127.0.0.1:58230_solr) [n:127.0.0.1:58230_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2900971 INFO (jetty-launcher-7023-thread-3) [n:127.0.0.1:58230_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2900972 INFO (jetty-launcher-7023-thread-3) [n:127.0.0.1:58230_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:58230_solr [junit4] 2> 2900973 INFO (jetty-launcher-7023-thread-3) [n:127.0.0.1:58230_solr ] o.a.s.c.Overseer Overseer (id=99319787444502540-127.0.0.1:58230_solr-n_0000000000) starting [junit4] 2> 2900984 INFO (jetty-launcher-7023-thread-3) [n:127.0.0.1:58230_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:58230_solr [junit4] 2> 2900985 INFO (jetty-launcher-7023-thread-1) [n:127.0.0.1:58242_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2900989 INFO (jetty-launcher-7023-thread-2) [n:127.0.0.1:58233_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2900989 INFO (jetty-launcher-7023-thread-4) [n:127.0.0.1:58227_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2900990 INFO (jetty-launcher-7023-thread-1) [n:127.0.0.1:58242_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2900993 INFO (jetty-launcher-7023-thread-2) [n:127.0.0.1:58233_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:58233_solr [junit4] 2> 2900993 INFO (jetty-launcher-7023-thread-4) [n:127.0.0.1:58227_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:58227_solr [junit4] 2> 2900993 INFO (jetty-launcher-7023-thread-1) [n:127.0.0.1:58242_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:58242_solr [junit4] 2> 2901116 INFO (zkCallback-7057-thread-1-processing-n:127.0.0.1:58230_solr) [n:127.0.0.1:58230_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 2901121 INFO (zkCallback-7049-thread-1-processing-n:127.0.0.1:58227_solr) [n:127.0.0.1:58227_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 2901121 INFO (zkCallback-7051-thread-1-processing-n:127.0.0.1:58233_solr) [n:127.0.0.1:58233_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 2901132 INFO (zkCallback-7047-thread-1-processing-n:127.0.0.1:58242_solr) [n:127.0.0.1:58242_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3) [junit4] 2> 2901167 INFO (zkCallback-7051-thread-1-processing-n:127.0.0.1:58233_solr) [n:127.0.0.1:58233_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2901168 INFO (zkCallback-7057-thread-1-processing-n:127.0.0.1:58230_solr) [n:127.0.0.1:58230_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2901168 INFO (zkCallback-7049-thread-1-processing-n:127.0.0.1:58227_solr) [n:127.0.0.1:58227_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2901169 INFO (zkCallback-7047-thread-2-processing-n:127.0.0.1:58242_solr) [n:127.0.0.1:58242_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2901203 INFO (jetty-launcher-7023-thread-2) [n:127.0.0.1:58233_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58233.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2901214 INFO (jetty-launcher-7023-thread-2) [n:127.0.0.1:58233_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58233.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2901214 INFO (jetty-launcher-7023-thread-2) [n:127.0.0.1:58233_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58233.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2901216 INFO (jetty-launcher-7023-thread-2) [n:127.0.0.1:58233_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\node4\. [junit4] 2> 2901238 INFO (jetty-launcher-7023-thread-3) [n:127.0.0.1:58230_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58230.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2901248 INFO (jetty-launcher-7023-thread-3) [n:127.0.0.1:58230_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58230.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2901249 INFO (jetty-launcher-7023-thread-3) [n:127.0.0.1:58230_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58230.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2901251 INFO (jetty-launcher-7023-thread-3) [n:127.0.0.1:58230_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\node3\. [junit4] 2> 2901311 INFO (jetty-launcher-7023-thread-1) [n:127.0.0.1:58242_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58242.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2901323 INFO (jetty-launcher-7023-thread-1) [n:127.0.0.1:58242_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58242.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2901323 INFO (jetty-launcher-7023-thread-1) [n:127.0.0.1:58242_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58242.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2901325 INFO (jetty-launcher-7023-thread-1) [n:127.0.0.1:58242_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\node1\. [junit4] 2> 2901426 INFO (jetty-launcher-7023-thread-4) [n:127.0.0.1:58227_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58227.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2901436 INFO (jetty-launcher-7023-thread-4) [n:127.0.0.1:58227_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58227.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2901436 INFO (jetty-launcher-7023-thread-4) [n:127.0.0.1:58227_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58227.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2901438 INFO (jetty-launcher-7023-thread-4) [n:127.0.0.1:58227_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\node2\. [junit4] 2> 2901492 INFO (zkConnectionManagerCallback-7065-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2901505 INFO (zkConnectionManagerCallback-7069-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2901507 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 2901509 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:58223/solr ready [junit4] 2> 2901515 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@6fa07c{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 2901516 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=32694286 [junit4] 2> 2901517 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 2901517 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@d33924: rootName = solr_58233, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@f48755 [junit4] 2> 2901522 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 2901523 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6f0bbb: rootName = solr_58233, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@173e2cc [junit4] 2> 2901528 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 2901528 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@63445f: rootName = solr_58233, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@106c206 [junit4] 2> 2901531 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:58233_solr [junit4] 2> 2901532 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 2901532 INFO (zkCallback-7049-thread-1-processing-n:127.0.0.1:58227_solr) [n:127.0.0.1:58227_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2901532 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2901532 INFO (zkCallback-7051-thread-1-processing-n:127.0.0.1:58233_solr) [n:127.0.0.1:58233_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2901532 INFO (zkCallback-7047-thread-2-processing-n:127.0.0.1:58242_solr) [n:127.0.0.1:58242_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2901532 INFO (zkCallback-7057-thread-1-processing-n:127.0.0.1:58230_solr) [n:127.0.0.1:58230_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2901533 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x160dad209cc000a, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> 2901533 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1ce052f{/solr,null,UNAVAILABLE} [junit4] 2> 2901536 INFO (zkCallback-7068-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2901537 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 2901538 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@a788c4{/solr,null,AVAILABLE} [junit4] 2> 2901538 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConnector@117bed2{HTTP/1.1,[http/1.1]}{127.0.0.1:58283} [junit4] 2> 2901538 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.Server Started @2908805ms [junit4] 2> 2901538 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=58282} [junit4] 2> 2901539 ERROR (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2901539 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.2.1 [junit4] 2> 2901539 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2901539 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2901539 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-01-09T12:08:07.227Z [junit4] 2> 2901543 INFO (zkConnectionManagerCallback-7071-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2901544 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2901556 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x160dad209cc000f, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> 2901559 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58223/solr [junit4] 2> 2901562 INFO (zkConnectionManagerCallback-7075-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2901566 INFO (zkConnectionManagerCallback-7077-thread-1-processing-n:127.0.0.1:58282_solr) [n:127.0.0.1:58282_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2901575 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58282_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 2901579 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58282_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2901582 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58282_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:58282_solr [junit4] 2> 2901585 INFO (zkCallback-7049-thread-2-processing-n:127.0.0.1:58227_solr) [n:127.0.0.1:58227_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2901585 INFO (zkCallback-7047-thread-2-processing-n:127.0.0.1:58242_solr) [n:127.0.0.1:58242_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2901585 INFO (zkCallback-7068-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2901586 INFO (zkCallback-7057-thread-1-processing-n:127.0.0.1:58230_solr) [n:127.0.0.1:58230_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2901589 INFO (zkCallback-7076-thread-1-processing-n:127.0.0.1:58282_solr) [n:127.0.0.1:58282_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2901905 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58282_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58282.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2901917 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58282_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58282.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2901917 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58282_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58282.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2901919 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58282_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\node4\. [junit4] 2> 2901997 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.TestPullReplicaErrorHandling Adding proxy for URL: http://127.0.0.1:58283/solr. Proxy: http://127.0.0.1:58282/solr [junit4] 2> 2901998 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@17c5abb{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 2902002 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=10088825 [junit4] 2> 2902003 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 2902003 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1d4988b: rootName = solr_58230, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@1d6e6cf [junit4] 2> 2902008 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 2902008 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1e94b74: rootName = solr_58230, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@173e2cc [junit4] 2> 2902013 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 2902013 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@167d69e: rootName = solr_58230, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@106c206 [junit4] 2> 2902016 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:58230_solr [junit4] 2> 2902017 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 2902017 INFO (zkCallback-7047-thread-2-processing-n:127.0.0.1:58242_solr) [n:127.0.0.1:58242_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2902018 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2902018 INFO (zkCallback-7068-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2902018 INFO (zkCallback-7057-thread-1-processing-n:127.0.0.1:58230_solr) [n:127.0.0.1:58230_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2902018 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.Overseer Overseer (id=99319787444502540-127.0.0.1:58230_solr-n_0000000000) closing [junit4] 2> 2902018 INFO (zkCallback-7049-thread-2-processing-n:127.0.0.1:58227_solr) [n:127.0.0.1:58227_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2902022 INFO (OverseerStateUpdate-99319787444502540-127.0.0.1:58230_solr-n_0000000000) [n:127.0.0.1:58230_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:58230_solr [junit4] 2> 2902021 WARN (OverseerAutoScalingTriggerThread-99319787444502540-127.0.0.1:58230_solr-n_0000000000) [n:127.0.0.1:58230_solr ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 2902018 INFO (zkCallback-7076-thread-1-processing-n:127.0.0.1:58282_solr) [n:127.0.0.1:58282_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2902024 INFO (zkCallback-7049-thread-2-processing-n:127.0.0.1:58227_solr) [n:127.0.0.1:58227_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:58227_solr [junit4] 2> 2902024 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@68c53{/solr,null,UNAVAILABLE} [junit4] 2> 2902026 INFO (zkCallback-7049-thread-2-processing-n:127.0.0.1:58227_solr) [n:127.0.0.1:58227_solr ] o.a.s.c.Overseer Overseer (id=99319787444502537-127.0.0.1:58227_solr-n_0000000002) starting [junit4] 2> 2902026 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 2902028 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1e05fef{/solr,null,AVAILABLE} [junit4] 2> 2902030 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConnector@140d4e9{HTTP/1.1,[http/1.1]}{127.0.0.1:58297} [junit4] 2> 2902031 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.Server Started @2909297ms [junit4] 2> 2902031 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=58295} [junit4] 2> 2902031 ERROR (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2902032 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.2.1 [junit4] 2> 2902032 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2902032 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2902032 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-01-09T12:08:07.720Z [junit4] 2> 2902035 INFO (zkConnectionManagerCallback-7080-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2902036 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2902050 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58223/solr [junit4] 2> 2902053 INFO (zkConnectionManagerCallback-7085-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2902058 INFO (zkConnectionManagerCallback-7087-thread-1-processing-n:127.0.0.1:58295_solr) [n:127.0.0.1:58295_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2902067 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58295_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 2902070 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58295_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2902073 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58295_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:58295_solr [junit4] 2> 2902074 INFO (zkCallback-7047-thread-2-processing-n:127.0.0.1:58242_solr) [n:127.0.0.1:58242_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2902074 INFO (zkCallback-7049-thread-2-processing-n:127.0.0.1:58227_solr) [n:127.0.0.1:58227_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2902074 INFO (zkCallback-7076-thread-1-processing-n:127.0.0.1:58282_solr) [n:127.0.0.1:58282_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2902074 INFO (zkCallback-7068-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2902076 INFO (zkCallback-7086-thread-1-processing-n:127.0.0.1:58295_solr) [n:127.0.0.1:58295_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2902285 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58295_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58295.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2902296 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58295_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58295.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2902297 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58295_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58295.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2902298 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58295_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\node3\. [junit4] 2> 2902355 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.TestPullReplicaErrorHandling Adding proxy for URL: http://127.0.0.1:58297/solr. Proxy: http://127.0.0.1:58295/solr [junit4] 2> 2902356 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@ded964{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 2902357 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2712749 [junit4] 2> 2902357 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 2902357 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@37c218: rootName = solr_58242, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@2fff60 [junit4] 2> 2902363 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 2902363 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@184ee5d: rootName = solr_58242, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@173e2cc [junit4] 2> 2902368 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 2902369 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1bb7d9e: rootName = solr_58242, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@106c206 [junit4] 2> 2902372 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:58242_solr [junit4] 2> 2902374 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 2902374 INFO (zkCallback-7047-thread-2-processing-n:127.0.0.1:58242_solr) [n:127.0.0.1:58242_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2902374 INFO (zkCallback-7049-thread-2-processing-n:127.0.0.1:58227_solr) [n:127.0.0.1:58227_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2902374 INFO (zkCallback-7068-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2902374 INFO (zkCallback-7086-thread-1-processing-n:127.0.0.1:58295_solr) [n:127.0.0.1:58295_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2902374 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2902374 INFO (zkCallback-7076-thread-1-processing-n:127.0.0.1:58282_solr) [n:127.0.0.1:58282_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2903876 WARN (zkCallback-7047-thread-2-processing-n:127.0.0.1:58242_solr) [n:127.0.0.1:58242_solr ] o.a.s.c.ZkController Unable to register nodeLost path for 127.0.0.1:58242_solr [junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /autoscaling/nodeLost/127.0.0.1:58242_solr [junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127) [junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51) [junit4] 2> at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:783) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.lambda$create$7(SolrZkClient.java:364) [junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.create(SolrZkClient.java:364) [junit4] 2> at org.apache.solr.cloud.ZkController.lambda$registerLiveNodesListener$2(ZkController.java:879) [junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.lambda$refreshLiveNodes$1(ZkStateReader.java:705) [junit4] 2> at java.util.concurrent.ConcurrentHashMap$KeySetView.forEach(ConcurrentHashMap.java:4649) [junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.refreshLiveNodes(ZkStateReader.java:704) [junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.access$900(ZkStateReader.java:74) [junit4] 2> at org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.refreshAndWatch(ZkStateReader.java:1105) [junit4] 2> at org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.process(ZkStateReader.java:1100) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$1.lambda$process$1(SolrZkClient.java:268) [junit4] 2> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> 2903877 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@12039f2{/solr,null,UNAVAILABLE} [junit4] 2> 2903879 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 2903879 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@43df90{/solr,null,AVAILABLE} [junit4] 2> 2903880 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConnector@406f8e{HTTP/1.1,[http/1.1]}{127.0.0.1:58310} [junit4] 2> 2903881 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.Server Started @2911147ms [junit4] 2> 2903881 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=58309} [junit4] 2> 2903881 ERROR (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2903881 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.2.1 [junit4] 2> 2903882 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2903882 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2903882 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-01-09T12:08:09.570Z [junit4] 2> 2903886 INFO (zkConnectionManagerCallback-7090-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2903887 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2903920 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x160dad209cc0015, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> 2903927 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58223/solr [junit4] 2> 2903930 INFO (zkConnectionManagerCallback-7094-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2903933 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x160dad209cc0016, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> 2903935 INFO (zkConnectionManagerCallback-7096-thread-1-processing-n:127.0.0.1:58309_solr) [n:127.0.0.1:58309_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2903945 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58309_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 2903948 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58309_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2903954 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58309_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:58309_solr [junit4] 2> 2903955 INFO (zkCallback-7049-thread-2-processing-n:127.0.0.1:58227_solr) [n:127.0.0.1:58227_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2903956 INFO (zkCallback-7068-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2903956 INFO (zkCallback-7086-thread-1-processing-n:127.0.0.1:58295_solr) [n:127.0.0.1:58295_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2903956 INFO (zkCallback-7076-thread-2-processing-n:127.0.0.1:58282_solr) [n:127.0.0.1:58282_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2903959 INFO (zkCallback-7095-thread-1-processing-n:127.0.0.1:58309_solr) [n:127.0.0.1:58309_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2904163 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58309_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58309.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2904174 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58309_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58309.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2904174 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58309_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58309.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2904177 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58309_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\node1\. [junit4] 2> 2904236 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.TestPullReplicaErrorHandling Adding proxy for URL: http://127.0.0.1:58310/solr. Proxy: http://127.0.0.1:58309/solr [junit4] 2> 2904238 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@912f16{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 2904239 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=16010211 [junit4] 2> 2904240 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 2904240 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@8d09d8: rootName = solr_58227, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@1ae9f37 [junit4] 2> 2904246 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 2904246 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1ebdf73: rootName = solr_58227, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@173e2cc [junit4] 2> 2904251 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 2904251 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1528c21: rootName = solr_58227, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@106c206 [junit4] 2> 2904254 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:58227_solr [junit4] 2> 2904257 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 2904258 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2904258 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.Overseer Overseer (id=99319787444502537-127.0.0.1:58227_solr-n_0000000002) closing [junit4] 2> 2904261 WARN (OverseerAutoScalingTriggerThread-99319787444502537-127.0.0.1:58227_solr-n_0000000002) [n:127.0.0.1:58227_solr ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 2904261 INFO (OverseerStateUpdate-99319787444502537-127.0.0.1:58227_solr-n_0000000002) [n:127.0.0.1:58227_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:58227_solr [junit4] 2> 2904261 INFO (zkCallback-7076-thread-2-processing-n:127.0.0.1:58282_solr) [n:127.0.0.1:58282_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2904262 INFO (zkCallback-7086-thread-1-processing-n:127.0.0.1:58295_solr) [n:127.0.0.1:58295_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2904262 INFO (zkCallback-7049-thread-2-processing-n:127.0.0.1:58227_solr) [n:127.0.0.1:58227_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2904262 INFO (zkCallback-7095-thread-1-processing-n:127.0.0.1:58309_solr) [n:127.0.0.1:58309_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2904262 INFO (zkCallback-7068-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2904266 INFO (zkCallback-7076-thread-1-processing-n:127.0.0.1:58282_solr) [n:127.0.0.1:58282_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:58282_solr [junit4] 2> 2904266 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@cfa124{/solr,null,UNAVAILABLE} [junit4] 2> 2904268 INFO (zkCallback-7076-thread-1-processing-n:127.0.0.1:58282_solr) [n:127.0.0.1:58282_solr ] o.a.s.c.Overseer Overseer (id=99319787444502545-127.0.0.1:58282_solr-n_0000000004) starting [junit4] 2> 2904269 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 2904276 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1ac8e9d{/solr,null,AVAILABLE} [junit4] 2> 2904283 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7d2baf{HTTP/1.1,[http/1.1]}{127.0.0.1:58323} [junit4] 2> 2904283 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.e.j.s.Server Started @2911550ms [junit4] 2> 2904283 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=58322} [junit4] 2> 2904284 ERROR (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2904285 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.2.1 [junit4] 2> 2904285 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2904285 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2904285 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-01-09T12:08:09.973Z [junit4] 2> 2904296 INFO (zkConnectionManagerCallback-7100-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2904298 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2904316 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58223/solr [junit4] 2> 2904320 INFO (zkConnectionManagerCallback-7104-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2904322 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x160dad209cc0019, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> 2904325 INFO (zkConnectionManagerCallback-7106-thread-1-processing-n:127.0.0.1:58322_solr) [n:127.0.0.1:58322_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2904337 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58322_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 2904340 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58322_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2904348 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58322_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:58322_solr [junit4] 2> 2904353 INFO (zkCallback-7068-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2904353 INFO (zkCallback-7086-thread-1-processing-n:127.0.0.1:58295_solr) [n:127.0.0.1:58295_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2904353 INFO (zkCallback-7076-thread-1-processing-n:127.0.0.1:58282_solr) [n:127.0.0.1:58282_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2904354 INFO (zkCallback-7095-thread-1-processing-n:127.0.0.1:58309_solr) [n:127.0.0.1:58309_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2904357 INFO (zkCallback-7105-thread-1-processing-n:127.0.0.1:58322_solr) [n:127.0.0.1:58322_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2904589 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58322_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58322.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2904606 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58322_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58322.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2904606 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58322_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58322.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2904611 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [n:127.0.0.1:58322_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\node2\. [junit4] 2> 2904684 INFO (SUITE-TestPullReplicaErrorHandling-seed#[1546513B510C22D5]-worker) [ ] o.a.s.c.TestPullReplicaErrorHandling Adding proxy for URL: http://127.0.0.1:58323/solr. Proxy: http://127.0.0.1:58322/solr [junit4] 2> 2904686 INFO (SocketProxy-Acceptor-58282) [ ] o.a.s.c.SocketProxy accepted Socket[addr=/127.0.0.1,port=58335,localport=58282], receiveBufferSize:65536 [junit4] 2> 2904686 INFO (SocketProxy-Acceptor-58282) [ ] o.a.s.c.SocketProxy proxy connection Socket[addr=/127.0.0.1,port=58283,localport=58336], receiveBufferSize=65536 [junit4] 2> 2904691 INFO (qtp30941501-31339) [n:127.0.0.1:58282_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterprop with params val=false&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 2904693 INFO (qtp30941501-31339) [n:127.0.0.1:58282_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={val=false&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 2904808 INFO (TEST-TestPullReplicaErrorHandling.testPullReplicaDisconnectsFromZooKeeper-seed#[1546513B510C22D5]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testPullReplicaDisconnectsFromZooKeeper [junit4] 2> 2904810 INFO (qtp30941501-31340) [n:127.0.0.1:58282_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params pullReplicas=1&replicationFactor=1&collection.configName=conf&maxShardsPerNode=1&name=pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper&nrtReplicas=1&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 2904814 INFO (OverseerThreadFactory-12430-thread-1-processing-n:127.0.0.1:58282_solr) [n:127.0.0.1:58282_solr ] o.a.s.c.CreateCollectionCmd Create collection pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper [junit4] 2> 2904926 INFO (OverseerStateUpdate-99319787444502545-127.0.0.1:58282_solr-n_0000000004) [n:127.0.0.1:58282_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:58295/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 2904930 INFO (OverseerStateUpdate-99319787444502545-127.0.0.1:58282_solr-n_0000000004) [n:127.0.0.1:58282_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:58309/solr", [junit4] 2> "type":"PULL", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 2905131 INFO (SocketProxy-Acceptor-58295) [ ] o.a.s.c.SocketProxy accepted Socket[addr=/127.0.0.1,port=58337,localport=58295], receiveBufferSize:65536 [junit4] 2> 2905131 INFO (SocketProxy-Acceptor-58309) [ ] o.a.s.c.SocketProxy accepted Socket[addr=/127.0.0.1,port=58338,localport=58309], receiveBufferSize:65536 [junit4] 2> 2905132 INFO (SocketProxy-Acceptor-58295) [ ] o.a.s.c.SocketProxy proxy connection Socket[addr=/127.0.0.1,port=58297,localport=58339], receiveBufferSize=65536 [junit4] 2> 2905132 INFO (SocketProxy-Acceptor-58309) [ ] o.a.s.c.SocketProxy proxy connection Socket[addr=/127.0.0.1,port=58310,localport=58340], receiveBufferSize=65536 [junit4] 2> 2905140 INFO (qtp13761576-31399) [n:127.0.0.1:58309_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2&action=CREATE&numShards=1&collection=pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper&shard=shard1&wt=javabin&version=2&replicaType=PULL [junit4] 2> 2905140 INFO (qtp33265692-31365) [n:127.0.0.1:58295_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_n1&action=CREATE&numShards=1&collection=pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 2905142 INFO (qtp33265692-31365) [n:127.0.0.1:58295_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2905142 INFO (qtp13761576-31399) [n:127.0.0.1:58309_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2905250 INFO (zkCallback-7086-thread-1-processing-n:127.0.0.1:58295_solr) [n:127.0.0.1:58295_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper/state.json] for collection [pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper] has occurred - updating... (live nodes size: [4]) [junit4] 2> 2905250 INFO (zkCallback-7095-thread-1-processing-n:127.0.0.1:58309_solr) [n:127.0.0.1:58309_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper/state.json] for collection [pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper] has occurred - updating... (live nodes size: [4]) [junit4] 2> 2905251 INFO (zkCallback-7086-thread-2-processing-n:127.0.0.1:58295_solr) [n:127.0.0.1:58295_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper/state.json] for collection [pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper] has occurred - updating... (live nodes size: [4]) [junit4] 2> 2905251 INFO (zkCallback-7095-thread-2-processing-n:127.0.0.1:58309_solr) [n:127.0.0.1:58309_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper/state.json] for collection [pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper] has occurred - updating... (live nodes size: [4]) [junit4] 2> 2906172 INFO (qtp13761576-31399) [n:127.0.0.1:58309_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node4 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.1 [junit4] 2> 2906172 INFO (qtp33265692-31365) [n:127.0.0.1:58295_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node3 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.1 [junit4] 2> 2906183 INFO (qtp33265692-31365) [n:127.0.0.1:58295_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node3 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_n1] o.a.s.s.IndexSchema [pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_n1] Schema name=minimal [junit4] 2> 2906183 INFO (qtp13761576-31399) [n:127.0.0.1:58309_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node4 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2] o.a.s.s.IndexSchema [pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2] Schema name=minimal [junit4] 2> 2906189 INFO (qtp33265692-31365) [n:127.0.0.1:58295_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node3 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 2906189 INFO (qtp13761576-31399) [n:127.0.0.1:58309_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node4 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 2906190 INFO (qtp13761576-31399) [n:127.0.0.1:58309_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node4 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2] o.a.s.c.CoreContainer Creating SolrCore 'pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2' using configuration from collection pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper, trusted=true [junit4] 2> 2906190 INFO (qtp33265692-31365) [n:127.0.0.1:58295_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node3 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_n1' using configuration from collection pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper, trusted=true [junit4] 2> 2906191 INFO (qtp33265692-31365) [n:127.0.0.1:58295_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node3 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58295.solr.core.pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper.shard1.replica_n1' (registry 'solr.core.pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2906191 INFO (qtp13761576-31399) [n:127.0.0.1:58309_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node4 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58309.solr.core.pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper.shard1.replica_p2' (registry 'solr.core.pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper.shard1.replica_p2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@17e7eb9 [junit4] 2> 2906191 INFO (qtp33265692-31365) [n:127.0.0.1:58295_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node3 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 2906191 INFO (qtp13761576-31399) [n:127.0.0.1:58309_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node4 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 2906191 INFO (qtp33265692-31365) [n:127.0.0.1:58295_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node3 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_n1] o.a.s.c.SolrCore [[pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_n1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\node3\pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_n1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\node3\.\pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_n1\data\] [junit4] 2> 2906191 INFO (qtp13761576-31399) [n:127.0.0.1:58309_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node4 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2] o.a.s.c.SolrCore [[pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\node1\pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\node1\.\pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2\data\] [junit4] 2> 2906325 INFO (qtp13761576-31399) [n:127.0.0.1:58309_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node4 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2906325 INFO (qtp13761576-31399) [n:127.0.0.1:58309_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node4 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2906326 INFO (qtp33265692-31365) [n:127.0.0.1:58295_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node3 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2906326 INFO (qtp33265692-31365) [n:127.0.0.1:58295_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node3 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2906327 INFO (qtp13761576-31399) [n:127.0.0.1:58309_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node4 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2] o.a.s.s.SolrIndexSearcher Opening [Searcher@199f115[pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2] main] [junit4] 2> 2906328 INFO (qtp33265692-31365) [n:127.0.0.1:58295_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node3 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2906328 INFO (qtp33265692-31365) [n:127.0.0.1:58295_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node3 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2906329 INFO (qtp13761576-31399) [n:127.0.0.1:58309_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node4 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 2906330 INFO (qtp13761576-31399) [n:127.0.0.1:58309_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node4 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 2906330 INFO (qtp33265692-31365) [n:127.0.0.1:58295_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node3 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@b4877b[pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_n1] main] [junit4] 2> 2906330 INFO (qtp13761576-31399) [n:127.0.0.1:58309_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node4 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 2906332 INFO (qtp33265692-31365) [n:127.0.0.1:58295_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node3 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 2906332 INFO (qtp13761576-31399) [n:127.0.0.1:58309_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node4 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2] o.a.s.c.ZkController pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2 starting background replication from leader [junit4] 2> 2906332 INFO (qtp13761576-31399) [n:127.0.0.1:58309_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node4 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2] o.a.s.c.ReplicateFromLeader Will start replication from leader with poll interval: 00:00:03 [junit4] 2> 2906332 INFO (searcherExecutor-12437-thread-1-processing-n:127.0.0.1:58309_solr x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2 s:shard1 c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper r:core_node4) [n:127.0.0.1:58309_solr c:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper s:shard1 r:core_node4 x:pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2] o.a.s.c.SolrCore [pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_shard1_replica_p2] Registered new searcher Searcher@199f115[pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper_sha [...truncated too long message...] version_=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=1117, maxMBSortInHeap=7.343507990367848, sim=RandomSimilarity(queryNorm=true): {}, locale=mk, timezone=America/North_Dakota/Beulah [junit4] 2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_144 (32-bit)/cpus=3,threads=1,free=167877408,total=518979584 [junit4] 2> NOTE: All tests run in this JVM: [PingRequestHandlerTest, MetricUtilsTest, TestLRUCache, TestCollationField, SegmentsInfoRequestHandlerTest, HttpSolrCallGetCoreTest, TestDocTermOrds, TestXmlQParser, CloneFieldUpdateProcessorFactoryTest, TestEmbeddedSolrServerConstructors, TestPerFieldSimilarityWithDefaultOverride, TestUniqueKeyFieldResource, WrapperMergePolicyFactoryTest, ComputePlanActionTest, BitVectorTest, NumberUtilsTest, AtomicUpdatesTest, TestPullReplica, TestLockTree, DeleteLastCustomShardedReplicaTest, TestNRTOpen, DOMUtilTest, CoreAdminRequestStatusTest, CdcrReplicationHandlerTest, MultiThreadedOCPTest, AutoAddReplicasPlanActionTest, TestStressCloudBlindAtomicUpdates, RuleEngineTest, TestJettySolrRunner, HdfsNNFailoverTest, TestOnReconnectListenerSupport, TestSolrCloudWithHadoopAuthPlugin, TestManagedSchema, TestClusterProperties, TestOverriddenPrefixQueryForCustomFieldType, TestDistributedGrouping, TestAnalyzeInfixSuggestions, TestLRUStatsCache, CollectionsAPIAsyncDistributedZkTest, TestRawResponseWriter, ShardRoutingCustomTest, ConjunctionSolrSpellCheckerTest, CloudExitableDirectoryReaderTest, TestStressVersions, TestGroupingSearch, TestSolrFieldCacheBean, SchemaVersionSpecificBehaviorTest, SolrCoreTest, TestFastWriter, TestUseDocValuesAsStored, TestSimpleQParserPlugin, MBeansHandlerTest, JsonLoaderTest, SolrJmxReporterTest, TestManagedResource, TestFunctionQuery, PolyFieldTest, PreAnalyzedFieldTest, TestInfoStreamLogging, TestSortByMinMaxFunction, LeaderElectionIntegrationTest, ClassificationUpdateProcessorIntegrationTest, TestFastOutputStream, FullSolrCloudDistribCmdsTest, TestCorePropertiesReload, LeaderInitiatedRecoveryOnCommitTest, TestShortCircuitedRequests, SolrCloudReportersTest, TestApiFramework, TestExactSharedStatsCache, EchoParamsTest, LegacyCloudClusterPropTest, EnumFieldTest, MoveReplicaHDFSTest, SampleTest, DistributedFacetPivotSmallTest, TestPostingsSolrHighlighter, AddSchemaFieldsUpdateProcessorFactoryTest, TestCollapseQParserPlugin, TestManagedSynonymFilterFactory, TestCSVLoader, TestSQLHandlerNonCloud, ConcurrentDeleteAndCreateCollectionTest, DebugComponentTest, CollectionStateFormat2Test, HLLUtilTest, FullHLLTest, BigEndianAscendingWordDeserializerTest, PreAnalyzedUpdateProcessorTest, DocumentAnalysisRequestHandlerTest, FileBasedSpellCheckerTest, CoreAdminHandlerTest, OverseerCollectionConfigSetProcessorTest, TestTolerantUpdateProcessorCloud, TestConfig, TestDelegationWithHadoopAuth, TermsComponentTest, SolrCoreCheckLockOnStartupTest, TestUtilizeNode, OpenExchangeRatesOrgProviderTest, MoreLikeThisHandlerTest, BasicFunctionalityTest, TestRetrieveFieldsOptimizer, TestPayloadScoreQParserPlugin, TestSubQueryTransformerCrossCore, ExitableDirectoryReaderTest, TestRuleBasedAuthorizationPlugin, HdfsWriteToMultipleCollectionsTest, HdfsAutoAddReplicasIntegrationTest, CacheHeaderTest, TestCollationFieldDocValues, SpellingQueryConverterTest, DistributedQueryComponentCustomSortTest, TestJavabinTupleStreamParser, TestBadConfig, TestShardHandlerFactory, TestStressLucene, UpdateLogTest, TestCollectionsAPIViaSolrCloudCluster, SolrIndexMetricsTest, AutoscalingHistoryHandlerTest, HdfsTlogReplayBufferedWhileIndexingTest, TestFieldResource, CustomCollectionTest, LukeRequestHandlerTest, AnalysisAfterCoreReloadTest, TestSolrIndexConfig, TestExclusionRuleCollectionAccess, RegexBytesRefFilterTest, TestRemoteStreaming, TestStressReorder, CdcrVersionReplicationTest, DataDrivenBlockJoinTest, TestCustomDocTransformer, TestLuceneMatchVersion, SuggestComponentContextFilterQueryTest, ShufflingReplicaListTransformerTest, SimpleCollectionCreateDeleteTest, HttpPartitionTest, PeerSyncTest, DistributedDebugComponentTest, TestSort, TestHttpShardHandlerFactory, ChaosMonkeyNothingIsSafeWithPullReplicasTest, TestSolrQueryParser, TestCloudNestedDocsSort, TestInitQParser, SoftAutoCommitTest, ReplaceNodeTest, TestRebalanceLeaders, TestCoreContainer, TestDynamicFieldResource, TestCloudInspectUtil, TestDefaultStatsCache, IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestQueryTypes, TestReRankQParserPlugin, TestSimpleTrackingShardHandler, BlockJoinFacetSimpleTest, BlockDirectoryTest, TimeRoutedAliasUpdateProcessorTest, CachingDirectoryFactoryTest, RestartWhileUpdatingTest, TestCryptoKeys, TemplateUpdateProcessorTest, TestStressLiveNodes, TestFaceting, TestLegacyField, RequestLoggingTest, TestAnalyzedSuggestions, TestPolicyCloud, TestPerFieldSimilarity, TestNumericRangeQuery64, TestBlobHandler, TestMultiValuedNumericRangeQuery, ChaosMonkeySafeLeaderTest, SpellPossibilityIteratorTest, TestConfigsApi, TestLeaderElectionWithEmptyReplica, DistributedFacetPivotLongTailTest, DistributedFacetExistsSmallTest, TestDistribDocBasedVersion, TestFastLRUCache, BasicDistributedZk2Test, UnloadDistributedZkTest, CollectionsAPIDistributedZkTest, OpenCloseCoreStressTest, OverseerTest, BasicZkTest, RecoveryZkTest, TestReplicationHandler, ClusterStateUpdateTest, TestRandomFaceting, ZkSolrClientTest, TestZkChroot, TestDistributedSearch, TestHashPartitioner, TestRealTimeGet, TestRangeQuery, TestSolr4Spatial, QueryElevationComponentTest, TestFiltering, DirectUpdateHandlerTest, ShowFileRequestHandlerTest, DistributedQueryElevationComponentTest, TestExtendedDismaxParser, SpellCheckCollatorTest, TestFoldingMultitermQuery, DocValuesTest, StatelessScriptUpdateProcessorFactoryTest, DistanceFunctionTest, SolrInfoBeanTest, TestSurroundQueryParser, TestWriterPerf, TestReversedWildcardFilterFactory, DocumentBuilderTest, PathHierarchyTokenizerFactoryTest, FieldAnalysisRequestHandlerTest, IndexSchemaRuntimeFieldTest, RegexBoostProcessorTest, SolrPluginUtilsTest, TestJmxIntegration, UniqFieldsUpdateProcessorFactoryTest, TestComponentsName, TestLFUCache, ResponseLogComponentTest, BadComponentTest, TestMergePolicyConfig, NumericFieldsTest, MinimalSchemaTest, TestPhraseSuggestions, TestCodecSupport, TestIBSimilarityFactory, TimeZoneUtilsTest, PluginInfoTest, DateMathParserTest, TestSystemIdResolver, PrimUtilsTest, TestSuggestSpellingConverter, ClusterStateTest, TestSolrJ, TestUtils, TestDocumentBuilder, ZkNodePropsTest, SliceStateTest, SystemInfoHandlerTest, FileUtilsTest, CircularListTest, DistributedMLTComponentTest, TestRTGBase, DistributedIntervalFacetingTest, TestCrossCoreJoin, TestDistributedMissingSort, TestHighlightDedupGrouping, TestTolerantSearch, TestLuceneIndexBackCompat, ActionThrottleTest, AddReplicaTest, AliasIntegrationTest, AssignTest, AsyncCallRequestStatusResponseTest, ChaosMonkeySafeLeaderWithPullReplicasTest, ConnectionManagerTest, DeleteReplicaTest, DeleteStatusTest, DistribDocExpirationUpdateProcessorTest, DocValuesNotIndexedTest, LeaderFailoverAfterPartitionTest, MissingSegmentRecoveryTest, MoveReplicaTest, RecoveryAfterSoftCommitTest, RemoteQueryErrorTest, SSLMigrationTest, ShardSplitTest, TestPullReplicaErrorHandling] [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestPullReplicaErrorHandling -Dtests.seed=1546513B510C22D5 -Dtests.slow=true -Dtests.locale=mk -Dtests.timezone=America/North_Dakota/Beulah -Dtests.asserts=true -Dtests.file.encoding=Cp1252 [junit4] ERROR 0.00s J1 | TestPullReplicaErrorHandling (suite) <<< [junit4] > Throwable #1: java.io.IOException: Could not remove the following files (in the order of attempts): [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper\server1\data\version-2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper\server1\data\version-2 [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper\server1\data: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper\server1\data [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper\server1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper\server1 [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001\zookeeper [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.2-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplicaErrorHandling_1546513B510C22D5-001\tempDir-001 [junit4] > at __randomizedtesting.SeedInfo.seed([1546513B510C22D5]:0) [junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] Completed [567/751 (1!)] on J1 in 186.85s, 3 tests, 1 error <<< FAILURES! [...truncated 43734 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org