You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2020/10/11 03:28:55 UTC
[JENKINS] Lucene-Solr-8.x-Windows (64bit/jdk-15) - Build # 1715 -
Still Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Windows/1715/
Java: 64bit/jdk-15 -XX:+UseCompressedOops -XX:+UseSerialGC
2 tests failed.
FAILED: org.apache.solr.cloud.autoscaling.sim.TestSnapshotCloudManager.testComplexSnapshot
Error Message:
committed = 143196160 should be < max = 143130624
Stack Trace:
java.lang.IllegalArgumentException: committed = 143196160 should be < max = 143130624
at __randomizedtesting.SeedInfo.seed([329BA15C860BD983:66BFA1E7AD437E38]:0)
at java.management/java.lang.management.MemoryUsage.<init>(MemoryUsage.java:166)
at java.management/sun.management.MemoryPoolImpl.getCollectionUsage0(Native Method)
at java.management/sun.management.MemoryPoolImpl.getCollectionUsage(MemoryPoolImpl.java:264)
at com.codahale.metrics.jvm.MemoryUsageGaugeSet.getMetrics(MemoryUsageGaugeSet.java:96)
at org.apache.solr.metrics.SolrMetricManager.registerAll(SolrMetricManager.java:557)
at org.apache.solr.cloud.autoscaling.sim.SimCloudManager.<init>(SimCloudManager.java:207)
at org.apache.solr.cloud.autoscaling.sim.SimCloudManager.createCluster(SimCloudManager.java:313)
at org.apache.solr.cloud.autoscaling.sim.TestSnapshotCloudManager.testComplexSnapshot(TestSnapshotCloudManager.java:148)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:64)
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:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at 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:832)
FAILED: org.apache.solr.cloud.autoscaling.sim.TestSnapshotCloudManager.testSimulatorFromSnapshot
Error Message:
committed = 143196160 should be < max = 143130624
Stack Trace:
java.lang.IllegalArgumentException: committed = 143196160 should be < max = 143130624
at __randomizedtesting.SeedInfo.seed([329BA15C860BD983:5CD0AC87E8C9E36F]:0)
at java.management/java.lang.management.MemoryUsage.<init>(MemoryUsage.java:166)
at java.management/sun.management.MemoryPoolImpl.getCollectionUsage0(Native Method)
at java.management/sun.management.MemoryPoolImpl.getCollectionUsage(MemoryPoolImpl.java:264)
at com.codahale.metrics.jvm.MemoryUsageGaugeSet.getMetrics(MemoryUsageGaugeSet.java:96)
at org.apache.solr.metrics.SolrMetricManager.registerAll(SolrMetricManager.java:557)
at org.apache.solr.cloud.autoscaling.sim.SimCloudManager.<init>(SimCloudManager.java:207)
at org.apache.solr.cloud.autoscaling.sim.SimCloudManager.createCluster(SimCloudManager.java:313)
at org.apache.solr.cloud.autoscaling.sim.TestSnapshotCloudManager.testSimulatorFromSnapshot(TestSnapshotCloudManager.java:165)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:64)
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:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at 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:832)
Build Log:
[...truncated 15483 lines...]
[junit4] Suite: org.apache.solr.cloud.autoscaling.sim.TestSnapshotCloudManager
[junit4] 2> 1557008 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of 'C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\server\solr\configsets\_default\conf'
[junit4] 2> 1557009 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.sim.TestSnapshotCloudManager_329BA15C860BD983-001\data-dir-140-001
[junit4] 2> 1557009 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1557010 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 1557010 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1557011 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 3 servers in C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.sim.TestSnapshotCloudManager_329BA15C860BD983-001\tempDir-001
[junit4] 2> 1557011 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1557012 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 1557012 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1557015 WARN (ZkTestServer Run Thread) [ ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 1557116 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port: 52319
[junit4] 2> 1557116 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:52319
[junit4] 2> 1557116 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:52319
[junit4] 2> 1557116 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 52319
[junit4] 2> 1557118 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1557120 INFO (zkConnectionManagerCallback-12984-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1557120 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1557128 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1557133 INFO (zkConnectionManagerCallback-12986-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1557133 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1557134 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1557139 INFO (zkConnectionManagerCallback-12988-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1557139 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1557247 WARN (jetty-launcher-12989-thread-3) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1557247 WARN (jetty-launcher-12989-thread-1) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1557247 WARN (jetty-launcher-12989-thread-2) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1557248 INFO (jetty-launcher-12989-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1557248 INFO (jetty-launcher-12989-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1557248 INFO (jetty-launcher-12989-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1557248 INFO (jetty-launcher-12989-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1557248 INFO (jetty-launcher-12989-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1557248 INFO (jetty-launcher-12989-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1557248 INFO (jetty-launcher-12989-thread-3) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 15+36-1562
[junit4] 2> 1557248 INFO (jetty-launcher-12989-thread-2) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 15+36-1562
[junit4] 2> 1557248 INFO (jetty-launcher-12989-thread-1) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 15+36-1562
[junit4] 2> 1557249 INFO (jetty-launcher-12989-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1557249 INFO (jetty-launcher-12989-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1557249 INFO (jetty-launcher-12989-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1557249 INFO (jetty-launcher-12989-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1557249 INFO (jetty-launcher-12989-thread-3) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1557249 INFO (jetty-launcher-12989-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1557249 INFO (jetty-launcher-12989-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1557249 INFO (jetty-launcher-12989-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1557249 INFO (jetty-launcher-12989-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1557249 INFO (jetty-launcher-12989-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@419b712d{/solr,null,AVAILABLE}
[junit4] 2> 1557249 INFO (jetty-launcher-12989-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5df7cca3{/solr,null,AVAILABLE}
[junit4] 2> 1557249 INFO (jetty-launcher-12989-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5f3b264{/solr,null,AVAILABLE}
[junit4] 2> 1557251 INFO (jetty-launcher-12989-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@78f5af45{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:52332}
[junit4] 2> 1557251 INFO (jetty-launcher-12989-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@433a19a3{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:52333}
[junit4] 2> 1557251 INFO (jetty-launcher-12989-thread-2) [ ] o.e.j.s.Server Started @1557177ms
[junit4] 2> 1557251 INFO (jetty-launcher-12989-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7100bd2e{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:52334}
[junit4] 2> 1557251 INFO (jetty-launcher-12989-thread-3) [ ] o.e.j.s.Server Started @1557177ms
[junit4] 2> 1557251 INFO (jetty-launcher-12989-thread-1) [ ] o.e.j.s.Server Started @1557177ms
[junit4] 2> 1557251 INFO (jetty-launcher-12989-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=52332}
[junit4] 2> 1557251 INFO (jetty-launcher-12989-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=52333}
[junit4] 2> 1557251 INFO (jetty-launcher-12989-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=52334}
[junit4] 2> 1557252 ERROR (jetty-launcher-12989-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1557252 ERROR (jetty-launcher-12989-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1557252 INFO (jetty-launcher-12989-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1557252 INFO (jetty-launcher-12989-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1557252 ERROR (jetty-launcher-12989-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1557252 INFO (jetty-launcher-12989-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1557252 INFO (jetty-launcher-12989-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.7.0
[junit4] 2> 1557252 INFO (jetty-launcher-12989-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.7.0
[junit4] 2> 1557252 INFO (jetty-launcher-12989-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.7.0
[junit4] 2> 1557252 INFO (jetty-launcher-12989-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1557252 INFO (jetty-launcher-12989-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1557252 INFO (jetty-launcher-12989-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr
[junit4] 2> 1557252 INFO (jetty-launcher-12989-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1557252 INFO (jetty-launcher-12989-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr
[junit4] 2> 1557252 INFO (jetty-launcher-12989-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr
[junit4] 2> 1557252 INFO (jetty-launcher-12989-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-10-11T03:06:09.337511500Z
[junit4] 2> 1557252 INFO (jetty-launcher-12989-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-10-11T03:06:09.337511500Z
[junit4] 2> 1557252 INFO (jetty-launcher-12989-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-10-11T03:06:09.337511500Z
[junit4] 2> 1557253 INFO (jetty-launcher-12989-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1557253 INFO (jetty-launcher-12989-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1557253 INFO (jetty-launcher-12989-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1557257 INFO (zkConnectionManagerCallback-12995-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1557258 INFO (zkConnectionManagerCallback-12993-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1557258 INFO (zkConnectionManagerCallback-12991-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1557258 INFO (jetty-launcher-12989-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1557258 INFO (jetty-launcher-12989-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1557258 INFO (jetty-launcher-12989-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1557258 INFO (jetty-launcher-12989-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1557258 INFO (jetty-launcher-12989-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1557258 INFO (jetty-launcher-12989-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1557696 INFO (jetty-launcher-12989-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1557700 WARN (jetty-launcher-12989-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@43ba3581[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1557700 WARN (jetty-launcher-12989-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@43ba3581[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1557700 WARN (jetty-launcher-12989-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6bf54c2c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1557700 WARN (jetty-launcher-12989-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6bf54c2c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1557704 INFO (jetty-launcher-12989-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:52319/solr
[junit4] 2> 1557704 INFO (jetty-launcher-12989-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1557712 INFO (zkConnectionManagerCallback-13011-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1557712 INFO (jetty-launcher-12989-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1557732 INFO (jetty-launcher-12989-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1557733 WARN (jetty-launcher-12989-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7988e3d9[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1557733 WARN (jetty-launcher-12989-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7988e3d9[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1557735 WARN (jetty-launcher-12989-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@12612ba8[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1557735 WARN (jetty-launcher-12989-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@12612ba8[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1557736 INFO (jetty-launcher-12989-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:52319/solr
[junit4] 2> 1557737 INFO (jetty-launcher-12989-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1557742 INFO (zkConnectionManagerCallback-13018-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1557742 INFO (jetty-launcher-12989-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1557785 INFO (jetty-launcher-12989-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1557787 WARN (jetty-launcher-12989-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@789ebffa[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1557787 WARN (jetty-launcher-12989-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@789ebffa[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1557791 WARN (jetty-launcher-12989-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@3bc89c00[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1557791 WARN (jetty-launcher-12989-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@3bc89c00[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1557792 INFO (jetty-launcher-12989-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:52319/solr
[junit4] 2> 1557793 INFO (jetty-launcher-12989-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1557798 INFO (zkConnectionManagerCallback-13025-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1557798 INFO (jetty-launcher-12989-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1557818 INFO (jetty-launcher-12989-thread-3) [n:127.0.0.1:52333_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1557824 INFO (zkConnectionManagerCallback-13027-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1557824 INFO (jetty-launcher-12989-thread-3) [n:127.0.0.1:52333_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1557920 INFO (jetty-launcher-12989-thread-2) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1557923 INFO (zkConnectionManagerCallback-13031-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1557923 INFO (jetty-launcher-12989-thread-2) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1557963 INFO (jetty-launcher-12989-thread-2) [n:127.0.0.1:52332_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:52332_solr
[junit4] 2> 1557967 INFO (jetty-launcher-12989-thread-2) [n:127.0.0.1:52332_solr ] o.a.s.c.Overseer Overseer (id=72100898457059338-127.0.0.1:52332_solr-n_0000000000) starting
[junit4] 2> 1557995 INFO (jetty-launcher-12989-thread-2) [n:127.0.0.1:52332_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52332_solr
[junit4] 2> 1557995 INFO (OverseerStateUpdate-72100898457059338-127.0.0.1:52332_solr-n_0000000000) [n:127.0.0.1:52332_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:52332_solr
[junit4] 2> 1557998 INFO (OverseerStateUpdate-72100898457059338-127.0.0.1:52332_solr-n_0000000000) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1558005 INFO (jetty-launcher-12989-thread-2) [n:127.0.0.1:52332_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1558005 WARN (jetty-launcher-12989-thread-2) [n:127.0.0.1:52332_solr ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 1558020 INFO (jetty-launcher-12989-thread-1) [n:127.0.0.1:52334_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1558025 INFO (zkConnectionManagerCallback-13041-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1558025 INFO (jetty-launcher-12989-thread-1) [n:127.0.0.1:52334_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1558025 INFO (jetty-launcher-12989-thread-2) [n:127.0.0.1:52332_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1558042 INFO (jetty-launcher-12989-thread-1) [n:127.0.0.1:52334_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1558057 INFO (jetty-launcher-12989-thread-2) [n:127.0.0.1:52332_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52332.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6a992896
[junit4] 2> 1558064 INFO (jetty-launcher-12989-thread-2) [n:127.0.0.1:52332_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52332.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6a992896
[junit4] 2> 1558064 INFO (jetty-launcher-12989-thread-2) [n:127.0.0.1:52332_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52332.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6a992896
[junit4] 2> 1558065 INFO (jetty-launcher-12989-thread-1) [n:127.0.0.1:52334_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:52334_solr as DOWN
[junit4] 2> 1558067 INFO (jetty-launcher-12989-thread-2) [n:127.0.0.1:52332_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.sim.TestSnapshotCloudManager_329BA15C860BD983-001\tempDir-001\node2
[junit4] 2> 1558070 INFO (jetty-launcher-12989-thread-1) [n:127.0.0.1:52334_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1558070 INFO (jetty-launcher-12989-thread-1) [n:127.0.0.1:52334_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52334_solr
[junit4] 2> 1558077 INFO (zkCallback-13030-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1558077 INFO (zkCallback-13040-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1558084 INFO (jetty-launcher-12989-thread-1) [n:127.0.0.1:52334_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1558084 WARN (jetty-launcher-12989-thread-1) [n:127.0.0.1:52334_solr ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 1558103 INFO (jetty-launcher-12989-thread-1) [n:127.0.0.1:52334_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1558121 INFO (jetty-launcher-12989-thread-1) [n:127.0.0.1:52334_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52334.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6a992896
[junit4] 2> 1558128 INFO (jetty-launcher-12989-thread-1) [n:127.0.0.1:52334_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52334.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6a992896
[junit4] 2> 1558128 INFO (jetty-launcher-12989-thread-1) [n:127.0.0.1:52334_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52334.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6a992896
[junit4] 2> 1558129 INFO (jetty-launcher-12989-thread-1) [n:127.0.0.1:52334_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.sim.TestSnapshotCloudManager_329BA15C860BD983-001\tempDir-001\node1
[junit4] 2> 1558238 INFO (jetty-launcher-12989-thread-3) [n:127.0.0.1:52333_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1558243 INFO (jetty-launcher-12989-thread-3) [n:127.0.0.1:52333_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:52333_solr as DOWN
[junit4] 2> 1558245 INFO (jetty-launcher-12989-thread-3) [n:127.0.0.1:52333_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1558245 INFO (jetty-launcher-12989-thread-3) [n:127.0.0.1:52333_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52333_solr
[junit4] 2> 1558247 INFO (zkCallback-13030-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1558247 INFO (zkCallback-13040-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1558248 INFO (zkCallback-13026-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1558248 INFO (jetty-launcher-12989-thread-3) [n:127.0.0.1:52333_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1558249 WARN (jetty-launcher-12989-thread-3) [n:127.0.0.1:52333_solr ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 1558262 INFO (jetty-launcher-12989-thread-3) [n:127.0.0.1:52333_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1558276 INFO (jetty-launcher-12989-thread-3) [n:127.0.0.1:52333_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52333.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6a992896
[junit4] 2> 1558283 INFO (jetty-launcher-12989-thread-3) [n:127.0.0.1:52333_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52333.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6a992896
[junit4] 2> 1558283 INFO (jetty-launcher-12989-thread-3) [n:127.0.0.1:52333_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52333.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6a992896
[junit4] 2> 1558284 INFO (jetty-launcher-12989-thread-3) [n:127.0.0.1:52333_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.sim.TestSnapshotCloudManager_329BA15C860BD983-001\tempDir-001\node3
[junit4] 2> 1558295 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=3
[junit4] 2> 1558296 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1558300 INFO (zkConnectionManagerCallback-13064-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1558300 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1558301 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 1558302 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:52319/solr ready
[junit4] 2> 1558315 INFO (qtp2143767718-19955) [n:127.0.0.1:52334_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params pullReplicas=1&name=.system&nrtReplicas=2&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1558334 INFO (OverseerThreadFactory-13038-thread-1-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection .system
[junit4] 2> 1558449 INFO (OverseerStateUpdate-72100898457059338-127.0.0.1:52332_solr-n_0000000000) [n:127.0.0.1:52332_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":".system",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:52334/solr",
[junit4] 2> "node_name":"127.0.0.1:52334_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1558455 INFO (OverseerStateUpdate-72100898457059338-127.0.0.1:52332_solr-n_0000000000) [n:127.0.0.1:52332_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":".system",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":".system_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:52333/solr",
[junit4] 2> "node_name":"127.0.0.1:52333_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1558461 INFO (OverseerStateUpdate-72100898457059338-127.0.0.1:52332_solr-n_0000000000) [n:127.0.0.1:52332_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":".system",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":".system_shard1_replica_p4",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:52332/solr",
[junit4] 2> "node_name":"127.0.0.1:52332_solr",
[junit4] 2> "type":"PULL",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1558665 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr x:.system_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n1&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1558665 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr x:.system_shard1_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node5&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n2&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1558665 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr x:.system_shard1_replica_p4 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node6&collection.configName=.system&newCollection=true&name=.system_shard1_replica_p4&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=PULL
[junit4] 2> 1558665 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr x:.system_shard1_replica_p4 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1558678 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
[junit4] 2> 1558678 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
[junit4] 2> 1558678 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
[junit4] 2> 1558696 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4 ] o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but managed schema resource managed-schema not found - loading non-managed schema schema.xml instead
[junit4] 2> 1558696 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but managed schema resource managed-schema not found - loading non-managed schema schema.xml instead
[junit4] 2> 1558696 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but managed schema resource managed-schema not found - loading non-managed schema schema.xml instead
[junit4] 2> 1558698 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4 ] o.a.s.s.IndexSchema Schema name=_system collection or core
[junit4] 2> 1558698 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=_system collection or core
[junit4] 2> 1558698 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.s.IndexSchema Schema name=_system collection or core
[junit4] 2> 1558701 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4 ] o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid field id
[junit4] 2> 1558701 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid field id
[junit4] 2> 1558701 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid field id
[junit4] 2> 1558707 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.c.CoreContainer Creating SolrCore '.system_shard1_replica_n2' using configuration from configset .system, trusted=true
[junit4] 2> 1558707 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4 ] o.a.s.c.CoreContainer Creating SolrCore '.system_shard1_replica_p4' using configuration from configset .system, trusted=true
[junit4] 2> 1558707 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52332.solr.core..system.shard1.replica_p4' (registry 'solr.core..system.shard1.replica_p4') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6a992896
[junit4] 2> 1558707 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52333.solr.core..system.shard1.replica_n2' (registry 'solr.core..system.shard1.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6a992896
[junit4] 2> 1558708 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.c.SolrCore [[.system_shard1_replica_n2] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.sim.TestSnapshotCloudManager_329BA15C860BD983-001\tempDir-001\node3\.system_shard1_replica_n2], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.sim.TestSnapshotCloudManager_329BA15C860BD983-001\tempDir-001\node3\.system_shard1_replica_n2\data\]
[junit4] 2> 1558708 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4 ] o.a.s.c.SolrCore [[.system_shard1_replica_p4] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.sim.TestSnapshotCloudManager_329BA15C860BD983-001\tempDir-001\node2\.system_shard1_replica_p4], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.sim.TestSnapshotCloudManager_329BA15C860BD983-001\tempDir-001\node2\.system_shard1_replica_p4\data\]
[junit4] 2> 1558709 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Created and persisted managed schema znode at /configs/.system/managed-schema
[junit4] 2> 1558721 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema in ZooKeeper, renamed the non-managed schema /configs/.system/schema.xml to /configs/.system/schema.xml.bak
[junit4] 2> 1558724 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore '.system_shard1_replica_n1' using configuration from configset .system, trusted=true
[junit4] 2> 1558724 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52334.solr.core..system.shard1.replica_n1' (registry 'solr.core..system.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6a992896
[junit4] 2> 1558724 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.SolrCore [[.system_shard1_replica_n1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.sim.TestSnapshotCloudManager_329BA15C860BD983-001\tempDir-001\node1\.system_shard1_replica_n1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.sim.TestSnapshotCloudManager_329BA15C860BD983-001\tempDir-001\node1\.system_shard1_replica_n1\data\]
[junit4] 2> 1558791 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1558791 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1558794 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.u.CommitTracker Hard AutoCommit: if 1 uncommitted docs;
[junit4] 2> 1558794 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1558796 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/.system
[junit4] 2> 1558796 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/.system
[junit4] 2> 1558796 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/.system/managed-schema
[junit4] 2> 1558797 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.s.ZkIndexSchemaReader Retrieved schema version 0 from Zookeeper
[junit4] 2> 1558799 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.s.IndexSchema Schema name=_system collection or core
[junit4] 2> 1558799 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid field id
[junit4] 2> 1558799 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 4 ms
[junit4] 2> 1558799 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 1558799 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4 ] o.a.s.u.CommitTracker Hard AutoCommit: if 1 uncommitted docs;
[junit4] 2> 1558799 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1558799 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1680223052375261184
[junit4] 2> 1558804 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/.system
[junit4] 2> 1558804 INFO (searcherExecutor-13067-thread-1-processing-n:127.0.0.1:52333_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node5) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.c.SolrCore [.system_shard1_replica_n2] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1558805 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/.system
[junit4] 2> 1558805 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4 ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/.system/managed-schema
[junit4] 2> 1558806 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1558806 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1558809 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4 ] o.a.s.s.ZkIndexSchemaReader Retrieved schema version 0 from Zookeeper
[junit4] 2> 1558809 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: if 1 uncommitted docs;
[junit4] 2> 1558809 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1558811 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4 ] o.a.s.s.IndexSchema Schema name=_system collection or core
[junit4] 2> 1558813 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/.system
[junit4] 2> 1558813 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4 ] o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid field id
[junit4] 2> 1558813 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4 ] o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 4 ms
[junit4] 2> 1558813 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/.system
[junit4] 2> 1558813 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/.system/managed-schema
[junit4] 2> 1558814 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 1558816 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/.system/terms/shard1 to Terms{values={core_node5=0}, version=0}
[junit4] 2> 1558816 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 1558816 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/.system/leaders/shard1
[junit4] 2> 1558816 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 1558816 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1680223052393086976
[junit4] 2> 1558817 INFO (searcherExecutor-13068-thread-1-processing-n:127.0.0.1:52332_solr x:.system_shard1_replica_p4 c:.system s:shard1 r:core_node6) [n:127.0.0.1:52332_solr c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4 ] o.a.s.c.SolrCore [.system_shard1_replica_p4] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1558820 INFO (searcherExecutor-13070-thread-1-processing-n:127.0.0.1:52334_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.SolrCore [.system_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1558830 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4 ] o.a.s.c.ZkController .system_shard1_replica_p4 starting background replication from leader
[junit4] 2> 1558830 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4 ] o.a.s.c.ReplicateFromLeader Will start replication from leader with poll interval: 00:00:01
[junit4] 2> 1558831 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4 ] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 1558831 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr c:.system s:shard1 r:core_node6 x:.system_shard1_replica_p4 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 1558833 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/.system/terms/shard1 to Terms{values={core_node3=0, core_node5=0}, version=1}
[junit4] 2> 1558833 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/.system/leaders/shard1
[junit4] 2> 1558834 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard1: total=2 found=1 timeoute in=9999ms
[junit4] 2> 1558936 INFO (zkCallback-13030-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [3])
[junit4] 2> 1558936 INFO (zkCallback-13030-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [3])
[junit4] 2> 1559335 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1559335 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1559335 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:52333/solr/.system_shard1_replica_n2/
[junit4] 2> 1559336 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.u.PeerSync PeerSync: core=.system_shard1_replica_n2 url=http://127.0.0.1:52333/solr START replicas=[http://127.0.0.1:52334/solr/.system_shard1_replica_n1/] nUpdates=100
[junit4] 2> 1559336 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.u.PeerSync PeerSync: core=.system_shard1_replica_n2 url=http://127.0.0.1:52333/solr DONE. We have no versions. sync failed.
[junit4] 2> 1559337 INFO (qtp2143767718-19958) [n:127.0.0.1:52334_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request [.system_shard1_replica_n1] webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1559338 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the next candidate
[junit4] 2> 1559338 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 1559338 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/.system/leaders/shard1/leader after winning as /collections/.system/leader_elect/shard1/election/72100898457059337-core_node5-n_0000000000
[junit4] 2> 1559343 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:52333/solr/.system_shard1_replica_n2/ shard1
[junit4] 2> 1559449 INFO (zkCallback-13026-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [3])
[junit4] 2> 1559449 INFO (zkCallback-13030-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [3])
[junit4] 2> 1559449 INFO (zkCallback-13030-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [3])
[junit4] 2> 1559451 INFO (indexFetcher-13083-thread-1) [ ] o.a.s.h.IndexFetcher Replica core_node5 is leader but it's state is down, skipping replication
[junit4] 2> 1559451 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1559457 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node5&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n2&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=792
[junit4] 2> 1559559 INFO (zkCallback-13026-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [3])
[junit4] 2> 1559559 INFO (zkCallback-13026-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [3])
[junit4] 2> 1559833 INFO (indexFetcher-13083-thread-1) [ ] o.a.s.h.IndexFetcher Last replication failed, so I'll force replication
[junit4] 2> 1559833 INFO (indexFetcher-13083-thread-1) [ ] o.a.s.h.IndexFetcher Updated leaderUrl to http://127.0.0.1:52333/solr/.system_shard1_replica_n2/
[junit4] 2> 1559835 INFO (qtp1308491372-19950) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.c.S.Request [.system_shard1_replica_n2] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 1559835 INFO (indexFetcher-13083-thread-1) [ ] o.a.s.h.IndexFetcher Leader's generation: 1
[junit4] 2> 1559835 INFO (indexFetcher-13083-thread-1) [ ] o.a.s.h.IndexFetcher Leader's version: 0
[junit4] 2> 1559835 INFO (indexFetcher-13083-thread-1) [ ] o.a.s.h.IndexFetcher Follower's generation: 1
[junit4] 2> 1559835 INFO (indexFetcher-13083-thread-1) [ ] o.a.s.h.IndexFetcher Follower's version: 0
[junit4] 2> 1559835 INFO (indexFetcher-13083-thread-1) [ ] o.a.s.h.IndexFetcher New index in Leader. Deleting mine...
[junit4] 2> 1559837 INFO (searcherExecutor-13068-thread-1) [ ] o.a.s.c.SolrCore [.system_shard1_replica_p4] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1559841 INFO (qtp1983012851-19957) [n:127.0.0.1:52332_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node6&collection.configName=.system&newCollection=true&name=.system_shard1_replica_p4&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=PULL} status=0 QTime=1176
[junit4] 2> 1559845 INFO (qtp2143767718-19952) [n:127.0.0.1:52334_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n1&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1180
[junit4] 2> 1559851 INFO (qtp2143767718-19955) [n:127.0.0.1:52334_solr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 1559947 INFO (zkCallback-13026-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [3])
[junit4] 2> 1559947 INFO (zkCallback-13040-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [3])
[junit4] 2> 1559947 INFO (zkCallback-13026-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [3])
[junit4] 2> 1559947 INFO (zkCallback-13030-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [3])
[junit4] 2> 1559947 INFO (zkCallback-13030-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [3])
[junit4] 2> 1559947 INFO (zkCallback-13040-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [3])
[junit4] 2> 1559949 INFO (qtp2143767718-19955) [n:127.0.0.1:52334_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={pullReplicas=1&name=.system&nrtReplicas=2&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2} status=0 QTime=1634
[junit4] 2> 1559949 INFO (qtp2143767718-19961) [n:127.0.0.1:52334_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params name=coll1&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1559957 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection coll1
[junit4] 2> 1559959 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default to /configs/coll1.AUTOCREATED
[junit4] 2> 1559959 INFO (OverseerCollectionConfigSetProcessor-72100898457059338-127.0.0.1:52332_solr-n_0000000000) [n:127.0.0.1:52332_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> 1559964 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/managed-schema to /configs/coll1.AUTOCREATED/managed-schema
[junit4] 2> 1559967 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/protwords.txt to /configs/coll1.AUTOCREATED/protwords.txt
[junit4] 2> 1559976 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_it.txt to /configs/coll1.AUTOCREATED/lang/contractions_it.txt
[junit4] 2> 1559984 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ca.txt to /configs/coll1.AUTOCREATED/lang/contractions_ca.txt
[junit4] 2> 1559992 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stemdict_nl.txt to /configs/coll1.AUTOCREATED/lang/stemdict_nl.txt
[junit4] 2> 1559999 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hy.txt to /configs/coll1.AUTOCREATED/lang/stopwords_hy.txt
[junit4] 2> 1560007 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_no.txt to /configs/coll1.AUTOCREATED/lang/stopwords_no.txt
[junit4] 2> 1560015 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_id.txt to /configs/coll1.AUTOCREATED/lang/stopwords_id.txt
[junit4] 2> 1560023 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_et.txt to /configs/coll1.AUTOCREATED/lang/stopwords_et.txt
[junit4] 2> 1560032 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_da.txt to /configs/coll1.AUTOCREATED/lang/stopwords_da.txt
[junit4] 2> 1560041 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ga.txt to /configs/coll1.AUTOCREATED/lang/stopwords_ga.txt
[junit4] 2> 1560048 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hi.txt to /configs/coll1.AUTOCREATED/lang/stopwords_hi.txt
[junit4] 2> 1560054 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ja.txt to /configs/coll1.AUTOCREATED/lang/stopwords_ja.txt
[junit4] 2> 1560062 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_pt.txt to /configs/coll1.AUTOCREATED/lang/stopwords_pt.txt
[junit4] 2> 1560069 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hu.txt to /configs/coll1.AUTOCREATED/lang/stopwords_hu.txt
[junit4] 2> 1560076 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_el.txt to /configs/coll1.AUTOCREATED/lang/stopwords_el.txt
[junit4] 2> 1560083 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ru.txt to /configs/coll1.AUTOCREATED/lang/stopwords_ru.txt
[junit4] 2> 1560089 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_tr.txt to /configs/coll1.AUTOCREATED/lang/stopwords_tr.txt
[junit4] 2> 1560096 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ar.txt to /configs/coll1.AUTOCREATED/lang/stopwords_ar.txt
[junit4] 2> 1560103 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/userdict_ja.txt to /configs/coll1.AUTOCREATED/lang/userdict_ja.txt
[junit4] 2> 1560111 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_eu.txt to /configs/coll1.AUTOCREATED/lang/stopwords_eu.txt
[junit4] 2> 1560119 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_it.txt to /configs/coll1.AUTOCREATED/lang/stopwords_it.txt
[junit4] 2> 1560128 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_cz.txt to /configs/coll1.AUTOCREATED/lang/stopwords_cz.txt
[junit4] 2> 1560136 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stoptags_ja.txt to /configs/coll1.AUTOCREATED/lang/stoptags_ja.txt
[junit4] 2> 1560145 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_fr.txt to /configs/coll1.AUTOCREATED/lang/contractions_fr.txt
[junit4] 2> 1560152 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_de.txt to /configs/coll1.AUTOCREATED/lang/stopwords_de.txt
[junit4] 2> 1560159 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fa.txt to /configs/coll1.AUTOCREATED/lang/stopwords_fa.txt
[junit4] 2> 1560166 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ga.txt to /configs/coll1.AUTOCREATED/lang/contractions_ga.txt
[junit4] 2> 1560172 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ca.txt to /configs/coll1.AUTOCREATED/lang/stopwords_ca.txt
[junit4] 2> 1560176 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_nl.txt to /configs/coll1.AUTOCREATED/lang/stopwords_nl.txt
[junit4] 2> 1560186 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_bg.txt to /configs/coll1.AUTOCREATED/lang/stopwords_bg.txt
[junit4] 2> 1560192 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_en.txt to /configs/coll1.AUTOCREATED/lang/stopwords_en.txt
[junit4] 2> 1560199 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_es.txt to /configs/coll1.AUTOCREATED/lang/stopwords_es.txt
[junit4] 2> 1560205 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_lv.txt to /configs/coll1.AUTOCREATED/lang/stopwords_lv.txt
[junit4] 2> 1560212 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ro.txt to /configs/coll1.AUTOCREATED/lang/stopwords_ro.txt
[junit4] 2> 1560218 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_th.txt to /configs/coll1.AUTOCREATED/lang/stopwords_th.txt
[junit4] 2> 1560226 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fr.txt to /configs/coll1.AUTOCREATED/lang/stopwords_fr.txt
[junit4] 2> 1560235 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_sv.txt to /configs/coll1.AUTOCREATED/lang/stopwords_sv.txt
[junit4] 2> 1560245 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fi.txt to /configs/coll1.AUTOCREATED/lang/stopwords_fi.txt
[junit4] 2> 1560255 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/hyphenations_ga.txt to /configs/coll1.AUTOCREATED/lang/hyphenations_ga.txt
[junit4] 2> 1560263 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_gl.txt to /configs/coll1.AUTOCREATED/lang/stopwords_gl.txt
[junit4] 2> 1560270 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/solrconfig.xml to /configs/coll1.AUTOCREATED/solrconfig.xml
[junit4] 2> 1560275 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/synonyms.txt to /configs/coll1.AUTOCREATED/synonyms.txt
[junit4] 2> 1560281 INFO (OverseerThreadFactory-13038-thread-2-processing-n:127.0.0.1:52332_solr) [n:127.0.0.1:52332_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/stopwords.txt to /configs/coll1.AUTOCREATED/stopwords.txt
[junit4] 2> 1560505 INFO (OverseerStateUpdate-72100898457059338-127.0.0.1:52332_solr-n_0000000000) [n:127.0.0.1:52332_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"coll1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"coll1_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:52333/solr",
[junit4] 2> "node_name":"127.0.0.1:52333_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1560707 INFO (qtp1308491372-19953) [n:127.0.0.1:52333_solr x:coll1_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=coll1.AUTOCREATED&newCollection=true&name=coll1_shard1_replica_n1&action=CREATE&numShards=1&collection=coll1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1560720 INFO (qtp1308491372-19953) [n:127.0.0.1:52333_solr c:coll1 s:shard1 r:core_node2 x:coll1_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
[junit4] 2> 1560736 INFO (qtp1308491372-19953) [n:127.0.0.1:52333_solr c:coll1 s:shard1 r:core_node2 x:coll1_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=default-config
[junit4] 2> 1560845 INFO (qtp1308491372-19956) [n:127.0.0.1:52333_solr c:.system s:shard1 r:core_node5 x:.system_shard1_replica_n2 ] o.a.s.c.S.Request [.system_shard1_replica_n2] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 1560846 INFO (indexFetcher-13083-thread-1) [ ] o.a.s.h.IndexFetcher Leader's generation: 1
[junit4] 2> 1560846 INFO (indexFetcher-13083-thread-1) [ ] o.a.s.h.IndexFetcher Leader's version: 0
[junit4] 2> 1560846 INFO (indexFetcher-13083-thread-1) [ ] o.a.s.h.IndexFetcher Follower's generation: 2
[junit4] 2> 1560846 INFO (indexFetcher-13083-thread-1) [ ] o.a.s.h.IndexFetcher Follower's version: 1602385571920
[junit4] 2> 1560846 INFO (indexFetcher-13083-thread-1) [ ] o.a.s.h.IndexFetcher New index in Leader. Deleting mine...
[junit4] 2> 1560848 INFO (searcherExecutor-13068-thread-1) [ ] o.a.s.c.SolrCore [.system_shard1_replica_p4] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1560889 INFO (qtp1308491372-19953) [n:127.0.0.1:52333_solr c:coll1 s:shard1 r:core_node2 x:coll1_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
[junit4] 2> 1560926 INFO (qtp1308491372-19953) [n:127.0.0.1:52333_solr c:coll1 s:shard1 r:core_node2 x:coll1_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'coll1_shard1_replica_n1' using configuration from configset coll1.AUTOCREATED, trusted=true
[junit4] 2> 1560926 INFO (qtp1308491372-19953) [n:127.0.0.1:52333_solr c:coll1 s:shard1 r:core_node2 x:coll1_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52333.solr.core.coll1.shard1.replica_n1' (registry 'solr.core.coll1.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6a992896
[junit4] 2> 1560926 INFO (qtp1308491372-19953) [n:127.0.0.1:52333_solr c:coll1 s:shard1 r:core_node2 x:coll1_shard1_replica_n1 ] o.a.s.c.SolrCore [[coll1_shard1_replica_n1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.sim.TestSnapshotCloudManager_329BA15C860BD983-001\tempDir-001\node3\coll1_shard1_replica_n1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.sim.TestSnapshotCloudManager_329BA15C860BD983-001\tempDir-001\node3\coll1_shard1_replica_n1\data\]
[junit4] 2> 1560996 INFO (qtp1308491372-19953) [n:127.0.0.1:52333_solr c:coll1 s:shard1 r:core_node2 x:coll1_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1560996 INFO (qtp1308491372-19953) [n:127.0.0.1:52333_solr c:coll1 s:shard1 r:core_node2 x:coll1_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1560998 INFO (qtp1308491372-19953) [n:127.0.0.1:52333_solr c:coll1 s:shard1 r:core_node2 x:coll1_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: if uncommitted for 15000ms;
[junit4] 2> 1560998 INFO (qtp1308491372-19953) [n:127.0.0.1:52333_solr c:coll1 s:shard1 r:core_node2 x:coll1_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1561000 INFO (qtp1308491372-19953) [n:127.0.0.1:52333_solr c:coll1 s:shard1 r:core_node2 x:coll1_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/coll1.AUTOCREATED
[junit4] 2> 1561000 INFO (qtp1308491372-19953) [n:127.0.0.1:52333_solr c:coll1 s:shard1 r:core_node2 x:coll1_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/coll1.AUTOCREATED
[junit4] 2> 1561000 INFO (qtp1308491372-19953) [n:127.0.0.1:52333_solr c:coll1 s:shard1 r:core_node2 x:coll1_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/coll1.AUTOCREATED/managed-schema
[junit4] 2> 1561001 INFO (qtp1308491372-19953) [n:127.0.0.1:52333_solr c:coll1 s:shard1 r:core_node2 x:coll1_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 1561001 INFO (qtp1308491372-19953) [n:127.0.0.1:52333_solr c:coll1 s:shard1 r:core_node2 x:coll1_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1561001 INFO (qtp1308491372-19953) [n:127.0.0.1:52333_solr c:coll1 s:shard1 r:core_node2 x:coll1_shard1_replica_n1 ] o.a.s.s.DirectSolrSpellChecker init: {name=default,field=_text_,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
[junit4] 2> 1561002 INFO (qtp1308491372-19953) [n:127.0.0.1:52333_solr c:coll1 s:shard1 r:core_node2 x:coll1_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 1561002 INFO (qtp1308491372-19953) [n:127.0.0.1:52333_solr c:coll1 s:shard1 r:core_node2 x:coll1_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1680223054685274112
[junit4] 2> 1561004 INFO (searcherExecutor-13085-thread-1-processing-n:127.0.0.1:52333_solr x:coll1_shard1_replica_n1 c:c
[...truncated too long message...]
c86d8ab
[junit4] 2> 1564284 INFO (jetty-closer-13098-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 1564284 INFO (jetty-closer-13098-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1d86dfb8: rootName = solr_52334, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@5953993e
[junit4] 2> 1564284 INFO (jetty-closer-13098-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null
[junit4] 2> 1564285 INFO (jetty-closer-13098-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 1564285 INFO (jetty-closer-13098-thread-3) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@238ea283: rootName = solr_52333, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@1c86d8ab
[junit4] 2> 1564288 INFO (jetty-closer-13098-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 1564288 INFO (jetty-closer-13098-thread-3) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@75d2e8c: rootName = solr_52333, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@5953993e
[junit4] 2> 1564288 INFO (jetty-closer-13098-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null
[junit4] 2> 1564380 INFO (jetty-closer-13098-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72100898457059338-127.0.0.1:52332_solr-n_0000000000) closing
[junit4] 2> 1564380 INFO (jetty-closer-13098-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@78f5af45{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 1564380 INFO (jetty-closer-13098-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5df7cca3{/solr,null,UNAVAILABLE}
[junit4] 2> 1564380 INFO (jetty-closer-13098-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1564481 INFO (jetty-closer-13098-thread-3) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@433a19a3{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 1564481 INFO (jetty-closer-13098-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@419b712d{/solr,null,UNAVAILABLE}
[junit4] 2> 1564481 INFO (jetty-closer-13098-thread-3) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1564581 INFO (jetty-closer-13098-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@7100bd2e{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 1564581 INFO (jetty-closer-13098-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5f3b264{/solr,null,UNAVAILABLE}
[junit4] 2> 1564581 INFO (jetty-closer-13098-thread-2) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1564584 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 1564791 WARN (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 7 /solr/collections/.system/terms/shard1
[junit4] 2> 4 /solr/clusterprops.json
[junit4] 2> 4 /solr/aliases.json
[junit4] 2> 3 /solr/configs/.system
[junit4] 2> 3 /solr/packages.json
[junit4] 2> 3 /solr/security.json
[junit4] 2> 3 /solr/configs/.system/managed-schema
[junit4] 2> 2 /solr/collections/coll1/terms/shard1
[junit4] 2> 2 /solr/collections/coll10/terms/shard1
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 26 /solr/collections/.system/state.json
[junit4] 2> 11 /solr/collections/coll1/state.json
[junit4] 2> 9 /solr/collections/coll10/state.json
[junit4] 2> 4 /solr/clusterstate.json
[junit4] 2> 2 /solr/autoscaling.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 42 /solr/overseer/queue
[junit4] 2> 16 /solr/collections
[junit4] 2> 12 /solr/live_nodes
[junit4] 2> 11 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> 1564798 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:52319
[junit4] 2> 1564799 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:52319
[junit4] 2> 1564799 INFO (SUITE-TestSnapshotCloudManager-seed#[329BA15C860BD983]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 52319
[junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.sim.TestSnapshotCloudManager_329BA15C860BD983-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene87): {}, docValues:{}, maxPointsInLeafNode=1896, maxMBSortInHeap=7.894573320140256, sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=so-DJ, timezone=Pacific/Port_Moresby
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 15 (64-bit)/cpus=6,threads=1,free=250508136,total=517644288
[junit4] 2> NOTE: All tests run in this JVM: [PreAnalyzedFieldManagedSchemaCloudTest, TestCollectionsAPIViaSolrCloudCluster, TestDistribIDF, HighlighterWithoutStoredIdTest, HttpPartitionTest, CdcrVersionReplicationTest, ResourceLoaderTest, HLLSerializationTest, TestInitQParser, SpatialHeatmapFacetsTest, TestSizeLimitedDistributedMap, ManagedSchemaRoundRobinCloudTest, TestIBSimilarityFactory, BigEndianAscendingWordDeserializerTest, SchemaApiFailureTest, TestConfigSetProperties, AddBlockUpdateTest, TestBadConfig, TestRecovery, SolrRrdBackendFactoryTest, LargeFieldTest, HdfsDirectoryFactoryTest, DistributedMLTComponentTest, TestGroupingSearch, SaslZkACLProviderTest, TestNamedUpdateProcessors, TestDistributedTracing, CoreAdminOperationTest, TestComplexPhraseLeadingWildcard, SolrLogAuditLoggerPluginTest, SolrJmxReporterCloudTest, TestStressThreadBackup, TestSerializedLuceneMatchVersion, TestIndexingPerformance, ReindexCollectionTest, CircularListTest, TestPullReplica, TestBlobHandler, SignatureUpdateProcessorFactoryTest, BadCopyFieldTest, TestEmbeddedSolrServerConstructors, ZookeeperReadAPITest, TestJsonFacetRefinement, TestTolerantUpdateProcessorCloud, PathHierarchyTokenizerFactoryTest, WordBreakSolrSpellCheckerTest, ConfigureRecoveryStrategyTest, TestChildDocTransformerHierarchy, TestSearcherReuse, TestCustomStream, XmlInterpolationTest, AnalyticsMergeStrategyTest, BasicZkTest, TestSort, PhrasesIdentificationComponentTest, SystemCollectionCompatTest, TestLeaderElectionZkExpiry, TestInfoStreamLogging, TestDynamicFieldCollectionResource, TestObjectReleaseTracker, TestCloudPhrasesIdentificationComponent, MetricsHandlerTest, TestSimScenario, MetricTriggerIntegrationTest, SortByFunctionTest, TestCloudSearcherWarming, TestSimGenericDistributedQueue, RankQParserPluginTest, XsltUpdateRequestHandlerTest, TestNRTOpen, TestHttpShardHandlerFactory, TestPerFieldSimilarity, TestStressUserVersions, ShowFileRequestHandlerTest, TestStreamBody, TestReversedWildcardFilterFactory, AuditLoggerPluginTest, ZkCLITest, NodeLostTriggerTest, DocValuesTest, TestCursorMarkWithoutUniqueKey, TestManagedResource, TestFieldTypeResource, OutputWriterTest, TestRawResponseWriter, NodeMutatorTest, DocValuesNotIndexedTest, CollectionsAPIAsyncDistributedZkTest, JWTAuthPluginTest, ConnectionManagerTest, CreateRoutedAliasTest, DeleteShardTest, DistribDocExpirationUpdateProcessorTest, MissingSegmentRecoveryTest, OverriddenZkACLAndCredentialsProvidersTest, OverseerTest, ReplaceNodeNoTargetTest, ReplaceNodeTest, ShardRoutingTest, TestConfigSetsAPIZkFailure, TestDeleteCollectionOnDownNodes, TestDistributedMap, TestDynamicFieldNamesIndexCorrectly, TestRequestForwarding, TestSolrCloudWithKerberosAlt, TestStressInPlaceUpdates, ZkNodePropsTest, ZkShardTermsTest, AssignTest, ConcurrentDeleteAndCreateCollectionTest, CustomCollectionTest, TestLocalFSCloudBackupRestore, AutoAddReplicasIntegrationTest, ScheduledTriggerIntegrationTest, TestPolicyCloud, TestSimClusterStateProvider, TestSimComputePlanAction, TestSimUtils, TestSnapshotCloudManager]
[junit4] Completed [592/920 (1!)] on J3 in 10.07s, 5 tests, 2 errors <<< FAILURES!
[...truncated 46104 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Windows/1715/consoleText
[repro] Revision: f1fccfbf7e84169330fc8df2fe2f56243cb8641a
[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseSerialGC"
[repro] JUnit rest result XML files will be moved to: ./repro-reports
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr\core
[repro] TestSnapshotCloudManager
[repro] ant compile-test
[...truncated 3476 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.TestSnapshotCloudManager" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseSerialGC" -Dtests.seed=329BA15C860BD983 -Dtests.slow=true -Dtests.locale=so-DJ -Dtests.timezone=Pacific/Port_Moresby -Dtests.asserts=true -Dtests.file.encoding=Cp1252
[...truncated 102 lines...]
[repro] Failures w/original seeds:
[repro] 0/5 failed: org.apache.solr.cloud.autoscaling.sim.TestSnapshotCloudManager
[repro] Exiting with code 0
[...truncated 98 lines...]