Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Windows/339/ Java: 64bit/jdk-9.0.1 -XX:+UseCompressedOops -XX:+UseSerialGC
3 tests failed. FAILED: org.apache.solr.cloud.autoscaling.ComputePlanActionTest.testNodeLost Error Message: Trigger was not fired even after 10 seconds Stack Trace: java.lang.AssertionError: Trigger was not fired even after 10 seconds at __randomizedtesting.SeedInfo.seed([742AF83E369660BB:CB3F36C0B57C053D]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.cloud.autoscaling.ComputePlanActionTest.testNodeLost(ComputePlanActionTest.java:193) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at 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.base/java.lang.Thread.run(Thread.java:844) FAILED: org.apache.solr.cloud.autoscaling.ComputePlanActionTest.testNodeAdded Error Message: Unexpected node in computed operation expected:<127.0.0.1:520[50]_solr> but was:<127.0.0.1:520[04]_solr> Stack Trace: org.junit.ComparisonFailure: Unexpected node in computed operation expected:<127.0.0.1:520[50]_solr> but was:<127.0.0.1:520[04]_solr> at __randomizedtesting.SeedInfo.seed([742AF83E369660BB:11E9AE499435C8B8]:0) at org.junit.Assert.assertEquals(Assert.java:125) at org.apache.solr.cloud.autoscaling.ComputePlanActionTest.testNodeAdded(ComputePlanActionTest.java:359) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at 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.base/java.lang.Thread.run(Thread.java:844) FAILED: junit.framework.TestSuite.org.apache.solr.search.stats.TestLRUStatsCache Error Message: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001\shard2\configsets\cdcr-cluster2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001\shard2\configsets\cdcr-cluster2 C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001\shard2\configsets: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001\shard2\configsets C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001\shard2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001\shard2 C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-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.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001\shard2\configsets\cdcr-cluster2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001\shard2\configsets\cdcr-cluster2 C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001\shard2\configsets: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001\shard2\configsets C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001\shard2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001\shard2 C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001 at __randomizedtesting.SeedInfo.seed([742AF83E369660BB]: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.base/java.lang.Thread.run(Thread.java:844) Build Log: [...truncated 13490 lines...] [junit4] Suite: org.apache.solr.cloud.autoscaling.ComputePlanActionTest [junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.ComputePlanActionTest_742AF83E369660BB-001\init-core-data-001 [junit4] 2> 2968740 INFO (SUITE-ComputePlanActionTest-seed#[742AF83E369660BB]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 2968742 INFO (SUITE-ComputePlanActionTest-seed#[742AF83E369660BB]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0) [junit4] 2> 2968743 INFO (SUITE-ComputePlanActionTest-seed#[742AF83E369660BB]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 2968744 INFO (SUITE-ComputePlanActionTest-seed#[742AF83E369660BB]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.ComputePlanActionTest_742AF83E369660BB-001\tempDir-001 [junit4] 2> 2968744 INFO (SUITE-ComputePlanActionTest-seed#[742AF83E369660BB]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 2968745 INFO (Thread-5166) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 2968745 INFO (Thread-5166) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 2968749 ERROR (Thread-5166) [ ] 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> 2968845 INFO (SUITE-ComputePlanActionTest-seed#[742AF83E369660BB]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:51826 [junit4] 2> 2968848 INFO (zkConnectionManagerCallback-7016-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2968861 INFO (jetty-launcher-7013-thread-1) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 2968862 INFO (jetty-launcher-7013-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7029e05f{/solr,null,AVAILABLE} [junit4] 2> 2968868 INFO (jetty-launcher-7013-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@ec44626{SSL,[ssl, http/1.1]}{127.0.0.1:51830} [junit4] 2> 2968869 INFO (jetty-launcher-7013-thread-1) [ ] o.e.j.s.Server Started @2970669ms [junit4] 2> 2968869 INFO (jetty-launcher-7013-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=51830} [junit4] 2> 2968869 ERROR (jetty-launcher-7013-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2968869 INFO (jetty-launcher-7013-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.0 [junit4] 2> 2968869 INFO (jetty-launcher-7013-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2968869 INFO (jetty-launcher-7013-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2968869 INFO (jetty-launcher-7013-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-12-11T23:56:07.534782700Z [junit4] 2> 2968879 INFO (zkConnectionManagerCallback-7018-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2968880 INFO (jetty-launcher-7013-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2968887 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 0x1604801d3760001, 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.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> 2968889 INFO (jetty-launcher-7013-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51826/solr [junit4] 2> 2968891 INFO (zkConnectionManagerCallback-7022-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2968895 INFO (zkConnectionManagerCallback-7024-thread-1-processing-n:127.0.0.1:51830_solr) [n:127.0.0.1:51830_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2969041 INFO (jetty-launcher-7013-thread-1) [n:127.0.0.1:51830_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2969042 INFO (jetty-launcher-7013-thread-1) [n:127.0.0.1:51830_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:51830_solr [junit4] 2> 2969043 INFO (jetty-launcher-7013-thread-1) [n:127.0.0.1:51830_solr ] o.a.s.c.Overseer Overseer (id=99158364482043907-127.0.0.1:51830_solr-n_0000000000) starting [junit4] 2> 2969051 INFO (jetty-launcher-7013-thread-1) [n:127.0.0.1:51830_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:51830_solr [junit4] 2> 2969055 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 2969056 INFO (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2969059 DEBUG (OverseerAutoScalingTriggerThread-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread Adding .autoAddReplicas trigger [junit4] 2> 2969060 DEBUG (OverseerAutoScalingTriggerThread-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1 [junit4] 2> 2969060 DEBUG (OverseerAutoScalingTriggerThread-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:51830_solr] [junit4] 2> 2969060 DEBUG (OverseerAutoScalingTriggerThread-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion -1 [junit4] 2> 2969060 DEBUG (OverseerAutoScalingTriggerThread-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1 [junit4] 2> 2969063 DEBUG (OverseerAutoScalingTriggerThread-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 2969063 DEBUG (OverseerAutoScalingTriggerThread-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1 [junit4] 2> 2969065 DEBUG (ScheduledTrigger-10889-thread-1) [n:127.0.0.1:51830_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: [127.0.0.1:51830_solr] [junit4] 2> 2969180 INFO (jetty-launcher-7013-thread-1) [n:127.0.0.1:51830_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_51830.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@b2d2cb3 [junit4] 2> 2969188 INFO (jetty-launcher-7013-thread-1) [n:127.0.0.1:51830_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_51830.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@b2d2cb3 [junit4] 2> 2969189 INFO (jetty-launcher-7013-thread-1) [n:127.0.0.1:51830_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_51830.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@b2d2cb3 [junit4] 2> 2969190 INFO (jetty-launcher-7013-thread-1) [n:127.0.0.1:51830_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.ComputePlanActionTest_742AF83E369660BB-001\tempDir-001\node1\. [junit4] 2> 2969209 INFO (zkConnectionManagerCallback-7028-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2969210 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 0x1604801d3760004, 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.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> 2969214 INFO (zkConnectionManagerCallback-7032-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2969215 INFO (SUITE-ComputePlanActionTest-seed#[742AF83E369660BB]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2969216 INFO (SUITE-ComputePlanActionTest-seed#[742AF83E369660BB]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:51826/solr ready [junit4] 2> 2969230 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testNodeWithMultipleReplicasLost [junit4] 2> 2969231 DEBUG (zkCallback-7023-thread-1-processing-n:127.0.0.1:51830_solr) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 2 [junit4] 2> 2969231 DEBUG (OverseerAutoScalingTriggerThread-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2 [junit4] 2> 2969236 DEBUG (OverseerAutoScalingTriggerThread-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers [junit4] 2> 2969237 DEBUG (OverseerAutoScalingTriggerThread-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 2969237 DEBUG (OverseerAutoScalingTriggerThread-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2 [junit4] 2> 2969252 INFO (qtp614520309-28936) [n:127.0.0.1:51830_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params name=testNodeLost&action=DELETE&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 2969255 INFO (OverseerThreadFactory-10891-thread-1-processing-n:127.0.0.1:51830_solr) [n:127.0.0.1:51830_solr ] o.a.s.c.OverseerCollectionMessageHandler Executing Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true [junit4] 2> 2969256 ERROR (OverseerThreadFactory-10891-thread-1-processing-n:127.0.0.1:51830_solr) [n:127.0.0.1:51830_solr ] o.a.s.c.OverseerCollectionMessageHandler Collection: testNodeLost operation: delete failed:org.apache.solr.common.SolrException: Could not find collection : testNodeLost [junit4] 2> at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:111) [junit4] 2> at org.apache.solr.cloud.OverseerCollectionMessageHandler.collectionCmd(OverseerCollectionMessageHandler.java:795) [junit4] 2> at org.apache.solr.cloud.DeleteCollectionCmd.call(DeleteCollectionCmd.java:91) [junit4] 2> at org.apache.solr.cloud.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:233) [junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:464) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188) [junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167) [junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641) [junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> [junit4] 2> 2969260 INFO (qtp614520309-28936) [n:127.0.0.1:51830_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=testNodeLost&action=DELETE&wt=javabin&version=2} status=400 QTime=8 [junit4] 2> 2969261 INFO (qtp614520309-28937) [n:127.0.0.1:51830_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params name=testNodeAdded&action=DELETE&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 2969264 INFO (OverseerCollectionConfigSetProcessor-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 2969265 INFO (OverseerThreadFactory-10891-thread-2-processing-n:127.0.0.1:51830_solr) [n:127.0.0.1:51830_solr ] o.a.s.c.OverseerCollectionMessageHandler Executing Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true [junit4] 2> 2969266 ERROR (OverseerThreadFactory-10891-thread-2-processing-n:127.0.0.1:51830_solr) [n:127.0.0.1:51830_solr ] o.a.s.c.OverseerCollectionMessageHandler Collection: testNodeAdded operation: delete failed:org.apache.solr.common.SolrException: Could not find collection : testNodeAdded [junit4] 2> at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:111) [junit4] 2> at org.apache.solr.cloud.OverseerCollectionMessageHandler.collectionCmd(OverseerCollectionMessageHandler.java:795) [junit4] 2> at org.apache.solr.cloud.DeleteCollectionCmd.call(DeleteCollectionCmd.java:91) [junit4] 2> at org.apache.solr.cloud.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:233) [junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:464) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188) [junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167) [junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641) [junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> [junit4] 2> 2969268 INFO (qtp614520309-28937) [n:127.0.0.1:51830_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=testNodeAdded&action=DELETE&wt=javabin&version=2} status=400 QTime=7 [junit4] 2> 2969269 INFO (qtp614520309-28933) [n:127.0.0.1:51830_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params name=testNodeWithMultipleReplicasLost&action=DELETE&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 2969271 INFO (OverseerCollectionConfigSetProcessor-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 2969272 INFO (OverseerThreadFactory-10891-thread-3-processing-n:127.0.0.1:51830_solr) [n:127.0.0.1:51830_solr ] o.a.s.c.OverseerCollectionMessageHandler Executing Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true [junit4] 2> 2969273 ERROR (OverseerThreadFactory-10891-thread-3-processing-n:127.0.0.1:51830_solr) [n:127.0.0.1:51830_solr ] o.a.s.c.OverseerCollectionMessageHandler Collection: testNodeWithMultipleReplicasLost operation: delete failed:org.apache.solr.common.SolrException: Could not find collection : testNodeWithMultipleReplicasLost [junit4] 2> at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:111) [junit4] 2> at org.apache.solr.cloud.OverseerCollectionMessageHandler.collectionCmd(OverseerCollectionMessageHandler.java:795) [junit4] 2> at org.apache.solr.cloud.DeleteCollectionCmd.call(DeleteCollectionCmd.java:91) [junit4] 2> at org.apache.solr.cloud.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:233) [junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:464) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188) [junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167) [junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641) [junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> [junit4] 2> 2969275 INFO (qtp614520309-28933) [n:127.0.0.1:51830_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=testNodeWithMultipleReplicasLost&action=DELETE&wt=javabin&version=2} status=400 QTime=6 [junit4] 2> 2969279 INFO (zkConnectionManagerCallback-7036-thread-1-processing-n:127.0.0.1:51830_solr) [n:127.0.0.1:51830_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2969281 INFO (qtp614520309-28930) [n:127.0.0.1:51830_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2969282 INFO (qtp614520309-28930) [n:127.0.0.1:51830_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:51826/solr ready [junit4] 2> 2969287 INFO (qtp614520309-28935) [n:127.0.0.1:51830_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0 QTime=0 [junit4] 2> 2969288 DEBUG (qtp614520309-28930) [n:127.0.0.1:51830_solr ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration [junit4] 2> 2969288 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 0x1604801d3760006, 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.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> 2969290 INFO (qtp614520309-28930) [n:127.0.0.1:51830_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=13 [junit4] 2> 2969292 DEBUG (zkCallback-7023-thread-1-processing-n:127.0.0.1:51830_solr) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 3 [junit4] 2> 2969292 DEBUG (OverseerAutoScalingTriggerThread-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 3 [junit4] 2> 2969292 DEBUG (OverseerAutoScalingTriggerThread-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers [junit4] 2> 2969292 DEBUG (OverseerAutoScalingTriggerThread-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 2969292 DEBUG (OverseerAutoScalingTriggerThread-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion 3 [junit4] 2> 2969294 INFO (zkConnectionManagerCallback-7040-thread-1-processing-n:127.0.0.1:51830_solr) [n:127.0.0.1:51830_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2969295 INFO (qtp614520309-28937) [n:127.0.0.1:51830_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2969296 INFO (qtp614520309-28937) [n:127.0.0.1:51830_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:51826/solr ready [junit4] 2> 2969299 INFO (qtp614520309-28933) [n:127.0.0.1:51830_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1 [junit4] 2> 2969300 DEBUG (qtp614520309-28937) [n:127.0.0.1:51830_solr ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration [junit4] 2> 2969300 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 0x1604801d3760007, 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.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> 2969301 INFO (qtp614520309-28937) [n:127.0.0.1:51830_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=11 [junit4] 2> 2969302 DEBUG (zkCallback-7023-thread-1-processing-n:127.0.0.1:51830_solr) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 4 [junit4] 2> 2969302 DEBUG (OverseerAutoScalingTriggerThread-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 4 [junit4] 2> 2969302 DEBUG (OverseerAutoScalingTriggerThread-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers [junit4] 2> 2969303 DEBUG (OverseerAutoScalingTriggerThread-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 2969304 DEBUG (OverseerAutoScalingTriggerThread-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 4, lastZnodeVersion 4 [junit4] 2> 2969305 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 2969305 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@773874f6{/solr,null,AVAILABLE} [junit4] 2> 2969307 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@784cf03b{SSL,[ssl, http/1.1]}{127.0.0.1:51856} [junit4] 2> 2969307 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.e.j.s.Server Started @2971107ms [junit4] 2> 2969307 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=51856} [junit4] 2> 2969307 ERROR (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2969307 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.0 [junit4] 2> 2969308 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2969308 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2969308 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-12-11T23:56:07.973632500Z [junit4] 2> 2969311 INFO (zkConnectionManagerCallback-7042-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2969314 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2969325 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51826/solr [junit4] 2> 2969327 INFO (zkConnectionManagerCallback-7046-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2969328 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 0x1604801d3760009, 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.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> 2969331 INFO (zkConnectionManagerCallback-7048-thread-1-processing-n:127.0.0.1:51856_solr) [n:127.0.0.1:51856_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2969339 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [n:127.0.0.1:51856_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2969342 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [n:127.0.0.1:51856_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2969348 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [n:127.0.0.1:51856_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:51856_solr [junit4] 2> 2969348 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"downnode", [junit4] 2> "node_name":"127.0.0.1:51856_solr"} current state version: 0 [junit4] 2> 2969348 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:51856_solr [junit4] 2> 2969349 INFO (zkCallback-7023-thread-1-processing-n:127.0.0.1:51830_solr) [n:127.0.0.1:51830_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 2969349 INFO (zkCallback-7047-thread-1-processing-n:127.0.0.1:51856_solr) [n:127.0.0.1:51856_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 2969350 INFO (zkCallback-7031-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 2969427 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [n:127.0.0.1:51856_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_51856.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@b2d2cb3 [junit4] 2> 2969439 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [n:127.0.0.1:51856_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_51856.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@b2d2cb3 [junit4] 2> 2969439 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [n:127.0.0.1:51856_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_51856.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@b2d2cb3 [junit4] 2> 2969441 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [n:127.0.0.1:51856_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.ComputePlanActionTest_742AF83E369660BB-001\tempDir-001\node2\. [junit4] 2> 2969473 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 2969474 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7c3507c6{/solr,null,AVAILABLE} [junit4] 2> 2969475 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@534f0fe0{SSL,[ssl, http/1.1]}{127.0.0.1:51868} [junit4] 2> 2969475 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.e.j.s.Server Started @2971276ms [junit4] 2> 2969475 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=51868} [junit4] 2> 2969475 ERROR (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2969475 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.0 [junit4] 2> 2969475 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2969475 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2969475 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-12-11T23:56:08.140774100Z [junit4] 2> 2969481 INFO (zkConnectionManagerCallback-7051-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2969482 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2969487 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 0x1604801d376000b, 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.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> 2969490 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51826/solr [junit4] 2> 2969492 INFO (zkConnectionManagerCallback-7055-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2969493 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 0x1604801d376000c, 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.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> 2969495 INFO (zkConnectionManagerCallback-7057-thread-1-processing-n:127.0.0.1:51868_solr) [n:127.0.0.1:51868_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2969503 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [n:127.0.0.1:51868_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 2969505 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [n:127.0.0.1:51868_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2969508 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [n:127.0.0.1:51868_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:51868_solr [junit4] 2> 2969509 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"downnode", [junit4] 2> "node_name":"127.0.0.1:51868_solr"} current state version: 0 [junit4] 2> 2969509 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:51868_solr [junit4] 2> 2969509 INFO (zkCallback-7023-thread-1-processing-n:127.0.0.1:51830_solr) [n:127.0.0.1:51830_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 2969509 INFO (zkCallback-7047-thread-1-processing-n:127.0.0.1:51856_solr) [n:127.0.0.1:51856_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 2969509 INFO (zkCallback-7031-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 2969510 INFO (zkCallback-7056-thread-1-processing-n:127.0.0.1:51868_solr) [n:127.0.0.1:51868_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 2969623 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [n:127.0.0.1:51868_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_51868.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@b2d2cb3 [junit4] 2> 2969635 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [n:127.0.0.1:51868_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_51868.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@b2d2cb3 [junit4] 2> 2969636 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [n:127.0.0.1:51868_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_51868.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@b2d2cb3 [junit4] 2> 2969637 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [n:127.0.0.1:51868_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.ComputePlanActionTest_742AF83E369660BB-001\tempDir-001\node3\. [junit4] 2> 2969684 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 2969685 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@720ca36d{/solr,null,AVAILABLE} [junit4] 2> 2969686 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@90dd7e0{SSL,[ssl, http/1.1]}{127.0.0.1:51880} [junit4] 2> 2969686 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.e.j.s.Server Started @2971486ms [junit4] 2> 2969686 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=51880} [junit4] 2> 2969686 ERROR (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2969687 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.0 [junit4] 2> 2969687 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2969687 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2969687 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-12-11T23:56:08.352673600Z [junit4] 2> 2969691 INFO (zkConnectionManagerCallback-7060-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2969692 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2969699 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51826/solr [junit4] 2> 2969701 INFO (zkConnectionManagerCallback-7064-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2969706 INFO (zkConnectionManagerCallback-7066-thread-1-processing-n:127.0.0.1:51880_solr) [n:127.0.0.1:51880_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2969713 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [n:127.0.0.1:51880_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 2969716 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [n:127.0.0.1:51880_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2969719 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [n:127.0.0.1:51880_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:51880_solr [junit4] 2> 2969720 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"downnode", [junit4] 2> "node_name":"127.0.0.1:51880_solr"} current state version: 0 [junit4] 2> 2969720 INFO (zkCallback-7023-thread-1-processing-n:127.0.0.1:51830_solr) [n:127.0.0.1:51830_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2969720 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:51880_solr [junit4] 2> 2969721 INFO (zkCallback-7056-thread-1-processing-n:127.0.0.1:51868_solr) [n:127.0.0.1:51868_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2969721 INFO (zkCallback-7047-thread-1-processing-n:127.0.0.1:51856_solr) [n:127.0.0.1:51856_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2969721 INFO (zkCallback-7031-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2969721 INFO (zkCallback-7065-thread-1-processing-n:127.0.0.1:51880_solr) [n:127.0.0.1:51880_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2969810 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [n:127.0.0.1:51880_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_51880.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@b2d2cb3 [junit4] 2> 2969818 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [n:127.0.0.1:51880_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_51880.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@b2d2cb3 [junit4] 2> 2969818 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [n:127.0.0.1:51880_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_51880.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@b2d2cb3 [junit4] 2> 2969819 INFO (TEST-ComputePlanActionTest.testNodeWithMultipleReplicasLost-seed#[742AF83E369660BB]) [n:127.0.0.1:51880_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.ComputePlanActionTest_742AF83E369660BB-001\tempDir-001\node4\. [junit4] 2> 2969860 INFO (zkConnectionManagerCallback-7069-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2969890 INFO (zkConnectionManagerCallback-7073-thread-1-processing-n:127.0.0.1:51856_solr) [n:127.0.0.1:51856_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2969892 INFO (qtp639117188-28981) [n:127.0.0.1:51856_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 2969893 INFO (qtp639117188-28981) [n:127.0.0.1:51856_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:51826/solr ready [junit4] 2> 2969898 INFO (qtp614520309-28935) [n:127.0.0.1:51830_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1 [junit4] 2> 2969904 INFO (qtp639117188-28983) [n:127.0.0.1:51856_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1 [junit4] 2> 2969930 INFO (qtp731976874-29005) [n:127.0.0.1:51868_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1 [junit4] 2> 2969956 INFO (qtp800096452-29029) [n:127.0.0.1:51880_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1 [junit4] 2> 2969956 DEBUG (qtp639117188-28981) [n:127.0.0.1:51856_solr ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration [junit4] 2> 2969958 INFO (qtp639117188-28981) [n:127.0.0.1:51856_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=70 [junit4] 2> 2969958 DEBUG (zkCallback-7023-thread-1-processing-n:127.0.0.1:51830_solr) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 5 [junit4] 2> 2969959 INFO (qtp614520309-28930) [n:127.0.0.1:51830_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=3&collection.configName=conf&name=testNodeWithMultipleReplicasLost&nrtReplicas=3&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 2969961 DEBUG (zkCallback-7023-thread-1-processing-n:127.0.0.1:51830_solr) [n:127.0.0.1:51830_solr ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:51856_solr, 127.0.0.1:51868_solr, 127.0.0.1:51880_solr, 127.0.0.1:51830_solr] [junit4] 2> 2969961 DEBUG (OverseerAutoScalingTriggerThread-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 5 [junit4] 2> 2969961 INFO (OverseerThreadFactory-10891-thread-4-processing-n:127.0.0.1:51830_solr) [n:127.0.0.1:51830_solr ] o.a.s.c.CreateCollectionCmd Create collection testNodeWithMultipleReplicasLost [junit4] 2> 2969962 INFO (OverseerCollectionConfigSetProcessor-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000004 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 2969963 DEBUG (OverseerAutoScalingTriggerThread-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 2969963 DEBUG (OverseerAutoScalingTriggerThread-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 5, lastZnodeVersion 5 [junit4] 2> 2969964 DEBUG (ScheduledTrigger-10889-thread-1) [n:127.0.0.1:51830_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: node_lost_trigger with currently live nodes: [127.0.0.1:51856_solr, 127.0.0.1:51868_solr, 127.0.0.1:51880_solr, 127.0.0.1:51830_solr] [junit4] 2> 2969967 INFO (qtp614520309-28932) [n:127.0.0.1:51830_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1 [junit4] 2> 2969973 INFO (qtp639117188-28979) [n:127.0.0.1:51856_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1 [junit4] 2> 2969978 INFO (qtp731976874-29000) [n:127.0.0.1:51868_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1 [junit4] 2> 2969984 INFO (qtp800096452-29032) [n:127.0.0.1:51880_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1 [junit4] 2> 2969991 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "name":"testNodeWithMultipleReplicasLost", [junit4] 2> "fromApi":"true", [junit4] 2> "replicationFactor":"3", [junit4] 2> "collection.configName":"conf", [junit4] 2> "numShards":"2", [junit4] 2> "nrtReplicas":"3", [junit4] 2> "stateFormat":"2", [junit4] 2> "operation":"create"} current state version: 0 [junit4] 2> 2969992 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.ClusterStateMutator building a new cName: testNodeWithMultipleReplicasLost [junit4] 2> 2969992 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/testNodeWithMultipleReplicasLost/state.json [junit4] 2> 2970095 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testNodeWithMultipleReplicasLost", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:51880/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} current state version: 0 [junit4] 2> 2970095 INFO (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testNodeWithMultipleReplicasLost", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:51880/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 2970096 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{ [junit4] 2> "range":"80000000-ffffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{}} [junit4] 2> 2970096 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{ [junit4] 2> "range":"80000000-ffffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{"core_node3":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard1_replica_n1", [junit4] 2> "base_url":"https://127.0.0.1:51880/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}}} [junit4] 2> 2970098 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testNodeWithMultipleReplicasLost", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard1_replica_n2", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:51868/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} current state version: 0 [junit4] 2> 2970098 INFO (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testNodeWithMultipleReplicasLost", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard1_replica_n2", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:51868/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 2970098 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{ [junit4] 2> "range":"80000000-ffffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{"core_node3":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard1_replica_n1", [junit4] 2> "base_url":"https://127.0.0.1:51880/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}}} [junit4] 2> 2970098 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{ [junit4] 2> "range":"80000000-ffffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{ [junit4] 2> "core_node3":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard1_replica_n1", [junit4] 2> "base_url":"https://127.0.0.1:51880/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}, [junit4] 2> "core_node5":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard1_replica_n2", [junit4] 2> "base_url":"https://127.0.0.1:51868/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}}} [junit4] 2> 2970099 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.Overseer processMessage: queueSize: 3, message = { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testNodeWithMultipleReplicasLost", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard1_replica_n4", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:51856/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} current state version: 0 [junit4] 2> 2970100 INFO (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testNodeWithMultipleReplicasLost", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard1_replica_n4", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:51856/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 2970101 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{ [junit4] 2> "range":"80000000-ffffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{ [junit4] 2> "core_node3":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard1_replica_n1", [junit4] 2> "base_url":"https://127.0.0.1:51880/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}, [junit4] 2> "core_node5":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard1_replica_n2", [junit4] 2> "base_url":"https://127.0.0.1:51868/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}}} [junit4] 2> 2970101 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{ [junit4] 2> "range":"80000000-ffffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{ [junit4] 2> "core_node3":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard1_replica_n1", [junit4] 2> "base_url":"https://127.0.0.1:51880/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}, [junit4] 2> "core_node5":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard1_replica_n2", [junit4] 2> "base_url":"https://127.0.0.1:51868/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}, [junit4] 2> "core_node7":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard1_replica_n4", [junit4] 2> "base_url":"https://127.0.0.1:51856/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}}} [junit4] 2> 2970102 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.Overseer processMessage: queueSize: 4, message = { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testNodeWithMultipleReplicasLost", [junit4] 2> "shard":"shard2", [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard2_replica_n6", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:51830/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} current state version: 0 [junit4] 2> 2970102 INFO (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testNodeWithMultipleReplicasLost", [junit4] 2> "shard":"shard2", [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard2_replica_n6", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:51830/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 2970103 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.SliceMutator Old Slice: shard2:{ [junit4] 2> "range":"0-7fffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{}} [junit4] 2> 2970103 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.SliceMutator New Slice: shard2:{ [junit4] 2> "range":"0-7fffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{"core_node9":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard2_replica_n6", [junit4] 2> "base_url":"https://127.0.0.1:51830/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}}} [junit4] 2> 2970104 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.Overseer processMessage: queueSize: 5, message = { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testNodeWithMultipleReplicasLost", [junit4] 2> "shard":"shard2", [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard2_replica_n8", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:51856/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} current state version: 0 [junit4] 2> 2970104 INFO (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testNodeWithMultipleReplicasLost", [junit4] 2> "shard":"shard2", [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard2_replica_n8", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:51856/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 2970106 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.SliceMutator Old Slice: shard2:{ [junit4] 2> "range":"0-7fffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{"core_node9":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard2_replica_n6", [junit4] 2> "base_url":"https://127.0.0.1:51830/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}}} [junit4] 2> 2970106 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.SliceMutator New Slice: shard2:{ [junit4] 2> "range":"0-7fffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{ [junit4] 2> "core_node9":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard2_replica_n6", [junit4] 2> "base_url":"https://127.0.0.1:51830/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}, [junit4] 2> "core_node11":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard2_replica_n8", [junit4] 2> "base_url":"https://127.0.0.1:51856/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}}} [junit4] 2> 2970107 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.Overseer processMessage: queueSize: 6, message = { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testNodeWithMultipleReplicasLost", [junit4] 2> "shard":"shard2", [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard2_replica_n10", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:51868/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} current state version: 0 [junit4] 2> 2970107 INFO (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testNodeWithMultipleReplicasLost", [junit4] 2> "shard":"shard2", [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard2_replica_n10", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:51868/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 2970109 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.SliceMutator Old Slice: shard2:{ [junit4] 2> "range":"0-7fffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{ [junit4] 2> "core_node9":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard2_replica_n6", [junit4] 2> "base_url":"https://127.0.0.1:51830/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}, [junit4] 2> "core_node11":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard2_replica_n8", [junit4] 2> "base_url":"https://127.0.0.1:51856/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}}} [junit4] 2> 2970109 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.SliceMutator New Slice: shard2:{ [junit4] 2> "range":"0-7fffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{ [junit4] 2> "core_node9":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard2_replica_n6", [junit4] 2> "base_url":"https://127.0.0.1:51830/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}, [junit4] 2> "core_node11":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard2_replica_n8", [junit4] 2> "base_url":"https://127.0.0.1:51856/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}, [junit4] 2> "core_node12":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard2_replica_n10", [junit4] 2> "base_url":"https://127.0.0.1:51868/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}}} [junit4] 2> 2970210 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/testNodeWithMultipleReplicasLost/state.json version: 0 [junit4] 2> 2970313 INFO (qtp800096452-29034) [n:127.0.0.1:51880_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=testNodeWithMultipleReplicasLost_shard1_replica_n1&action=CREATE&numShards=2&collection=testNodeWithMultipleReplicasLost&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 2970314 INFO (qtp800096452-29034) [n:127.0.0.1:51880_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2970346 INFO (qtp639117188-28978) [n:127.0.0.1:51856_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=testNodeWithMultipleReplicasLost_shard1_replica_n4&action=CREATE&numShards=2&collection=testNodeWithMultipleReplicasLost&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 2970347 INFO (qtp639117188-28978) [n:127.0.0.1:51856_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2970349 INFO (qtp614520309-28936) [n:127.0.0.1:51830_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node9&collection.configName=conf&newCollection=true&name=testNodeWithMultipleReplicasLost_shard2_replica_n6&action=CREATE&numShards=2&collection=testNodeWithMultipleReplicasLost&shard=shard2&wt=javabin&version=2&replicaType=NRT [junit4] 2> 2970350 INFO (qtp614520309-28936) [n:127.0.0.1:51830_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2970354 INFO (qtp731976874-29006) [n:127.0.0.1:51868_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=testNodeWithMultipleReplicasLost_shard1_replica_n2&action=CREATE&numShards=2&collection=testNodeWithMultipleReplicasLost&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 2970354 INFO (qtp731976874-29006) [n:127.0.0.1:51868_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2970358 INFO (qtp731976874-29000) [n:127.0.0.1:51868_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node12&collection.configName=conf&newCollection=true&name=testNodeWithMultipleReplicasLost_shard2_replica_n10&action=CREATE&numShards=2&collection=testNodeWithMultipleReplicasLost&shard=shard2&wt=javabin&version=2&replicaType=NRT [junit4] 2> 2970358 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.Overseer processMessage: queueSize: 3, message = { [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard1_replica_n4", [junit4] 2> "core_node_name":"core_node7", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:51856/solr", [junit4] 2> "node_name":"127.0.0.1:51856_solr", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"testNodeWithMultipleReplicasLost", [junit4] 2> "type":"NRT", [junit4] 2> "operation":"state"} current state version: 0 [junit4] 2> 2970359 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard1_replica_n4", [junit4] 2> "core_node_name":"core_node7", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:51856/solr", [junit4] 2> "node_name":"127.0.0.1:51856_solr", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"testNodeWithMultipleReplicasLost", [junit4] 2> "type":"NRT", [junit4] 2> "operation":"state"} [junit4] 2> 2970359 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node7:{"core":"testNodeWithMultipleReplicasLost_shard1_replica_n4","base_url":"https://127.0.0.1:51856/solr","node_name":"127.0.0.1:51856_solr","state":"down","type":"NRT"} [junit4] 2> 2970359 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(testNodeWithMultipleReplicasLost//collections/testNodeWithMultipleReplicasLost/state.json/1)={ [junit4] 2> "pullReplicas":"0", [junit4] 2> "replicationFactor":"3", [junit4] 2> "router":{"name":"compositeId"}, [junit4] 2> "maxShardsPerNode":"1", [junit4] 2> "autoAddReplicas":"false", [junit4] 2> "nrtReplicas":"3", [junit4] 2> "tlogReplicas":"0", [junit4] 2> "shards":{ [junit4] 2> "shard1":{ [junit4] 2> "range":"80000000-ffffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{ [junit4] 2> "core_node3":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard1_replica_n1", [junit4] 2> "base_url":"https://127.0.0.1:51880/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}, [junit4] 2> "core_node5":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard1_replica_n2", [junit4] 2> "base_url":"https://127.0.0.1:51868/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}, [junit4] 2> "core_node7":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard1_replica_n4", [junit4] 2> "base_url":"https://127.0.0.1:51856/solr", [junit4] 2> "node_name":"127.0.0.1:51856_solr", [junit4] 2> "state":"down", [junit4] 2> "type":"NRT"}}}, [junit4] 2> "shard2":{ [junit4] 2> "range":"0-7fffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{ [junit4] 2> "core_node9":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard2_replica_n6", [junit4] 2> "base_url":"https://127.0.0.1:51830/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}, [junit4] 2> "core_node11":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard2_replica_n8", [junit4] 2> "base_url":"https://127.0.0.1:51856/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}, [junit4] 2> "core_node12":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard2_replica_n10", [junit4] 2> "base_url":"https://127.0.0.1:51868/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}}}}} [junit4] 2> 2970359 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.Overseer processMessage: queueSize: 3, message = { [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard2_replica_n6", [junit4] 2> "core_node_name":"core_node9", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:51830/solr", [junit4] 2> "node_name":"127.0.0.1:51830_solr", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard2", [junit4] 2> "collection":"testNodeWithMultipleReplicasLost", [junit4] 2> "type":"NRT", [junit4] 2> "operation":"state"} current state version: 0 [junit4] 2> 2970359 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard2_replica_n6", [junit4] 2> "core_node_name":"core_node9", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:51830/solr", [junit4] 2> "node_name":"127.0.0.1:51830_solr", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard2", [junit4] 2> "collection":"testNodeWithMultipleReplicasLost", [junit4] 2> "type":"NRT", [junit4] 2> "operation":"state"} [junit4] 2> 2970359 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node9:{"core":"testNodeWithMultipleReplicasLost_shard2_replica_n6","base_url":"https://127.0.0.1:51830/solr","node_name":"127.0.0.1:51830_solr","state":"down","type":"NRT"} [junit4] 2> 2970359 DEBUG (OverseerStateUpdate-99158364482043907-127.0.0.1:51830_solr-n_0000000000) [n:127.0.0.1:51830_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(testNodeWithMultipleReplicasLost//collections/testNodeWithMultipleReplicasLost/state.json/1)={ [junit4] 2> "pullReplicas":"0", [junit4] 2> "replicationFactor":"3", [junit4] 2> "router":{"name":"compositeId"}, [junit4] 2> "maxShardsPerNode":"1", [junit4] 2> "autoAddReplicas":"false", [junit4] 2> "nrtReplicas":"3", [junit4] 2> "tlogReplicas":"0", [junit4] 2> "shards":{ [junit4] 2> "shard1":{ [junit4] 2> "range":"80000000-ffffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{ [junit4] 2> "core_node3":{ [junit4] 2> "core":"testNodeWithMultipleReplicasLost_shard1_replica_n1", [junit4] 2> "base_url":"https://127.0.0.1:51880/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}, [junit4] 2> " [...truncated too long message...] FUCache, UUIDFieldTest, CdcrRequestHandlerTest, AutoAddReplicasIntegrationTest, ConnectionReuseTest, TestCoreDiscovery, TestCoreAdminApis, OverseerModifyCollectionTest, TestXIncludeConfig, TestReplicaProperties, LargeFieldTest, QueryParsingTest, SpatialFilterTest, HdfsChaosMonkeyNothingIsSafeTest, BlockJoinFacetRandomTest, BasicAuthIntegrationTest, ConfigSetsAPITest, MinimalSchemaTest, TestSolrQueryResponse, NodeLostTriggerTest, TestSchemalessBufferedUpdates, TestConfigSets, ManagedSchemaRoundRobinCloudTest, TestUseDocValuesAsStored2, TestCodecSupport, TestMissingGroups, TestRandomRequestDistribution, TestRecovery, TestSolrDeletionPolicy2, TestSystemCollAutoCreate, SolrCmdDistributorTest, TestFieldCacheVsDocValues, IndexSchemaTest, HttpTriggerListenerTest, ReplicationFactorTest, TestSolrCloudWithSecureImpersonation, PKIAuthenticationIntegrationTest, DateFieldTest, TestSolrCoreProperties, TestPayloadCheckQParserPlugin, TestTolerantSearch, TestConfigReload, HdfsBasicDistributedZk2Test, TestDownShardTolerantSearch, BufferStoreTest, TestCustomStream, AddReplicaTest, TestDocBasedVersionConstraints, DateMathParserTest, TestBackupRepositoryFactory, TestHashQParserPlugin, TestEmbeddedSolrServerAdminHandler, TestPullReplicaErrorHandling, TestSolrCoreSnapshots, CoreAdminCreateDiscoverTest, DistributedFacetPivotLargeTest, TestConfigSetImmutable, ResourceLoaderTest, ConvertedLegacyTest, TestLocalFSCloudBackupRestore, ImplicitSnitchTest, XmlUpdateRequestHandlerTest, CursorPagingTest, TestExpandComponent, DistributedFacetPivotWhiteBoxTest, AnalyticsQueryTest, HighlighterTest, HLLSerializationTest, TestLeaderElectionZkExpiry, TestConfigSetsAPI, RequestHandlersTest, CheckHdfsIndexTest, SolrTestCaseJ4Test, TestMiniSolrCloudClusterSSL, DirectUpdateHandlerTest, CollectionTooManyReplicasTest, SolrCLIZkUtilsTest, NoCacheHeaderTest, HdfsRestartWhileUpdatingTest, TestRealTimeGet, TestCSVResponseWriter, TestBulkSchemaConcurrent, TestZkAclsWithHadoopAuth, TestNonDefinedSimilarityFactory, TestPointFields, XsltUpdateRequestHandlerTest, TestImplicitCoreProperties, ForceLeaderTest, CdcrReplicationDistributedZkTest, TestNestedDocsSort, JvmMetricsTest, ChaosMonkeyNothingIsSafeTest, RollingRestartTest, TestIntervalFaceting, DefaultValueUpdateProcessorTest, ShardRoutingTest, DirectUpdateHandlerOptimizeTest, TestQuerySenderNoQuery, TestAtomicUpdateErrorCases, TestPhraseSuggestions, ZkCLITest, DistribCursorPagingTest, TestQuerySenderListener, TestBinaryField, LeaderFailureAfterFreshStartTest, CurrencyFieldTypeTest, MoveReplicaTest, MigrateRouteKeyTest, GraphQueryTest, TestTlogReplica, TestDistributedSearch, TestNoOpRegenerator, AlternateDirectoryTest, RegexBoostProcessorTest, TestPivotHelperCode, RankQueryTest, SortByFunctionTest, SpellCheckComponentTest, TestIndexingPerformance, TestRawTransformer, TestFilteredDocIdSet, BasicDistributedZkTest, SolrXmlInZkTest, CdcrUpdateLogTest, SolrCoreMetricManagerTest, V2StandaloneTest, DistributedTermsComponentTest, CoreMergeIndexesAdminHandlerTest, TestReversedWildcardFilterFactory, TestHdfsUpdateLog, TestPKIAuthenticationPlugin, TestTolerantUpdateProcessorRandomCloud, TestOrdValues, OverseerTest, HdfsLockFactoryTest, TestImpersonationWithHadoopAuth, ScriptEngineTest, RequiredFieldsTest, PrimUtilsTest, BigEndianAscendingWordSerializerTest, SolrRequestParserTest, TestBadConfig, SoftAutoCommitTest, DistributedQueryElevationComponentTest, CoreAdminHandlerTest, SuggesterTSTTest, SuggesterTest, SuggesterWFSTTest, TestCSVLoader, WordBreakSolrSpellCheckerTest, SchemaVersionSpecificBehaviorTest, DistanceFunctionTest, IndexBasedSpellCheckerTest, LukeRequestHandlerTest, PrimitiveFieldTypeTest, TestOmitPositions, TestValueSourceCache, TermVectorComponentTest, TestSolrQueryParser, IndexSchemaRuntimeFieldTest, SolrPluginUtilsTest, ReturnFieldsTest, TestAnalyzedSuggestions, TestPHPSerializedResponseWriter, CSVRequestHandlerTest, TestComponentsName, SearchHandlerTest, UpdateParamsTest, TestMergePolicyConfig, TestFuzzyAnalyzedSuggestions, SynonymTokenizerTest, TestSweetSpotSimilarityFactory, TestLMDirichletSimilarityFactory, TestIBSimilarityFactory, TimeZoneUtilsTest, URLClassifyProcessorTest, TestSystemIdResolver, ClusterStateTest, TestUtils, SliceStateTest, FileUtilsTest, DistributedMLTComponentTest, TestHighlightDedupGrouping, TestSimpleTrackingShardHandler, AssignBackwardCompatibilityTest, ChaosMonkeyNothingIsSafeWithPullReplicasTest, CreateCollectionCleanupTest, DistributedQueueTest, DistributedVersionInfoTest, LeaderElectionContextKeyTest, LeaderInitiatedRecoveryOnShardRestartTest, LegacyCloudClusterPropTest, MissingSegmentRecoveryTest, MoveReplicaHDFSFailoverTest, MoveReplicaHDFSTest, MultiThreadedOCPTest, NodeMutatorTest, OverriddenZkACLAndCredentialsProvidersTest, OverseerStatusTest, OverseerTaskQueueTest, PeerSyncReplicationTest, SolrCloudExampleTest, TestCloudPseudoReturnFields, TestCloudRecovery, TestCollectionAPI, TestDeleteCollectionOnDownNodes, TestExclusionRuleCollectionAccess, TestHdfsCloudBackupRestore, TestLeaderElectionWithEmptyReplica, TestLockTree, TestOnReconnectListenerSupport, TestRebalanceLeaders, TestRequestStatusCollectionAPI, TestSkipOverseerOperations, TestStressInPlaceUpdates, TestUtilizeNode, VMParamsZkACLAndCredentialsProvidersTest, ComputePlanActionTest, HdfsAutoAddReplicasIntegrationTest, NodeAddedTriggerTest, SearchRateTriggerTest, CdcrBidirectionalTest, CdcrReplicationHandlerTest, HdfsBasicDistributedZkTest, HdfsCollectionsAPIDistributedZkTest, HdfsNNFailoverTest, HdfsRecoverLeaseTest, HdfsRecoveryZkTest, HdfsThreadLeakTest, HdfsTlogReplayBufferedWhileIndexingTest, HdfsUnloadDistributedZkTest, HdfsWriteToMultipleCollectionsTest, StressHdfsTest, ZkStateReaderTest, ZkStateWriterTest, RulesTest, HdfsDirectoryFactoryTest, QueryResultKeyTest, TestConfigOverlay, TestConfigSetProperties, TestInitParams, TestNRTOpen, TestReloadAndDeleteDocs, TestSimpleTextCodec, TestSolrXml, RequestLoggingTest, SearchHandlerTest, TestBlobHandler, TestCoreBackup, TestHdfsBackupRestoreCore, TestReplicationHandlerBackup, TestReqParamsAPI, TestSQLHandler, V2ApiIntegrationTest, InfoHandlerTest, MetricsHandlerTest, SecurityConfHandlerTest, SegmentsInfoRequestHandlerTest, StatsReloadRaceTest, TestApiFramework, TestCollectionAPIs, DistributedExpandComponentTest, DistributedFacetExistsSmallTest, DistributedFacetPivotSmallAdvancedTest, DistributedFacetPivotSmallTest, DistributedQueryComponentOptimizationTest, FacetPivotSmallTest, ReplicaListTransformerTest, ShufflingReplicaListTransformerTest, SpatialHeatmapFacetsTest, SolrCloudReportersTest, RegexBytesRefFilterTest, TestStreamBody, TestMacroExpander, JSONWriterTest, TestBinaryResponseWriter, TestGeoJSONResponseWriter, TestGraphMLResponseWriter, TestPushWriter, TestSubQueryTransformer, TestSubQueryTransformerCrossCore, TestManagedResource, TestManagedResourceStorage, TestRestManager, TestBulkSchemaAPI, TestSchemaNameResource, TestSchemaSimilarityResource, TestSerializedLuceneMatchVersion, BadCopyFieldTest, DateRangeFieldTest, DocValuesMissingTest, TestManagedSchemaThreadSafety, TestSchemaManager, TestUseDocValuesAsStored, TestAddFieldRealTimeGet, TestCollapseQParserPlugin, TestComplexPhraseQParserPlugin, TestCustomSort, TestLegacyNumericRangeQueryBuilder, TestMaxScoreQueryParser, TestQueryWrapperFilter, TestRandomCollapseQParserPlugin, TestReRankQParserPlugin, TestRecoveryHdfs, TestReloadDeadlock, TestSearcherReuse, TestSimpleQParserPlugin, TestSmileRequest, TestSolr4Spatial2, TestSolrFieldCacheBean, TestStandardQParsers, TestTrieFacet, TestXmlQParser, TestXmlQParserPlugin, TestJsonFacetRefinement, TestJsonFacets, TestExactSharedStatsCache, TestLRUStatsCache] [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestLRUStatsCache -Dtests.seed=742AF83E369660BB -Dtests.slow=true -Dtests.locale=pa-Guru -Dtests.timezone=America/Rio_Branco -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 0.00s J0 | TestLRUStatsCache (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.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001\shard2\configsets\cdcr-cluster2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001\shard2\configsets\cdcr-cluster2 [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001\shard2\configsets: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001\shard2\configsets [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001\shard2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001\shard2 [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestLRUStatsCache_742AF83E369660BB-001\tempDir-001 [junit4] > at __randomizedtesting.SeedInfo.seed([742AF83E369660BB]:0) [junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329) [junit4] > at java.base/java.lang.Thread.run(Thread.java:844) [junit4] Completed [720/751 (2!)] on J0 in 8.88s, 1 test, 1 error <<< FAILURES! [...truncated 40231 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org