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/04/28 09:49:36 UTC
[JENKINS] Lucene-Solr-8.x-Linux (64bit/jdk1.8.0_201) - Build # 2895
- Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/2895/
Java: 64bit/jdk1.8.0_201 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
1 tests failed.
FAILED: org.apache.solr.cloud.autoscaling.sim.TestSimScenario.testSuggestions
Error Message:
OverseerTriggerThread never caught up to the latest znodeVersion
Stack Trace:
java.util.concurrent.TimeoutException: OverseerTriggerThread never caught up to the latest znodeVersion
at __randomizedtesting.SeedInfo.seed([6E71CCF15FED0624:C8ADF50491D951DA]:0)
at org.apache.solr.util.TimeOut.waitFor(TimeOut.java:66)
at org.apache.solr.cloud.autoscaling.sim.SimScenario$LoadAutoscaling.execute(SimScenario.java:464)
at org.apache.solr.cloud.autoscaling.sim.SimScenario.run(SimScenario.java:1106)
at org.apache.solr.cloud.autoscaling.sim.TestSimScenario.testSuggestions(TestSimScenario.java:94)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 14833 lines...]
[junit4] Suite: org.apache.solr.cloud.autoscaling.sim.TestSimScenario
[junit4] 2> 491332 INFO (SUITE-TestSimScenario-seed#[6E71CCF15FED0624]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/solr/configsets/_default/conf'
[junit4] 2> 491333 INFO (SUITE-TestSimScenario-seed#[6E71CCF15FED0624]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J3/temp/solr.cloud.autoscaling.sim.TestSimScenario_6E71CCF15FED0624-001/data-dir-70-001
[junit4] 2> 491333 WARN (SUITE-TestSimScenario-seed#[6E71CCF15FED0624]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=27 numCloses=27
[junit4] 2> 491333 INFO (SUITE-TestSimScenario-seed#[6E71CCF15FED0624]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 491335 INFO (SUITE-TestSimScenario-seed#[6E71CCF15FED0624]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 491335 INFO (SUITE-TestSimScenario-seed#[6E71CCF15FED0624]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 491337 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testIndexing
[junit4] 2> 491357 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 1. CreateCluster numNodes=100
[junit4] 2> 491357 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario CreateCluster numNodes=100
[junit4] 2> 491364 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.SolrPaths solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 491386 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers
[junit4] 2> 491386 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1
[junit4] 2> 491387 DEBUG (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimClusterStateProvider --- new Overseer leader: 127.0.0.1:10000_solr
[junit4] 2> 491387 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 0
[junit4] 2> 491387 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
[junit4] 2> 491387 DEBUG (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=0
[junit4] 2> 491388 DEBUG (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 0
[junit4] 2> 491388 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 491390 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:10001_solr, 127.0.0.1:10004_solr, 127.0.0.1:10018_solr, 127.0.0.1:10017_solr, 127.0.0.1:10002_solr, 127.0.0.1:10012_solr, 127.0.0.1:10007_solr, 127.0.0.1:10015_solr, 127.0.0.1:10006_solr, 127.0.0.1:10010_solr, 127.0.0.1:10016_solr, 127.0.0.1:10005_solr, 127.0.0.1:10009_solr, 127.0.0.1:10013_solr, 127.0.0.1:10000_solr, 127.0.0.1:10008_solr, 127.0.0.1:10014_solr, 127.0.0.1:10003_solr, 127.0.0.1:10011_solr]
[junit4] 2> 491391 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
[junit4] 2> 491391 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
[junit4] 2> 491391 DEBUG (ScheduledTrigger-7743-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 46 and last live nodes: 19
[junit4] 2> 491395 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 2. LoadAutoscaling json={'cluster-policy':[]}
[junit4] 2> 491395 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario LoadAutoscaling json={'cluster-policy':[]}
[junit4] 2> 491396 DEBUG (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 2
[junit4] 2> 491397 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
[junit4] 2> 491397 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
[junit4] 2> 491397 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
[junit4] 2> 491397 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 3. RunSolrRequest path=/admin/collections&action=CREATE&autoAddReplicas=true&name=testCollection&numShards=2&replicationFactor=2&maxShardsPerNode=2
[junit4] 2> 491398 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario RunSolrRequest path=/admin/collections&action=CREATE&autoAddReplicas=true&name=testCollection&numShards=2&replicationFactor=2&maxShardsPerNode=2
[junit4] 2> 491399 DEBUG (simCloudManagerPool-7742-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider -- simCreateCollection testCollection, currentVersion=1
[junit4] 2> 491399 DEBUG (simCloudManagerPool-7742-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=1
[junit4] 2> 491400 DEBUG (simCloudManagerPool-7742-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 1
[junit4] 2> 491411 DEBUG (simCloudManagerPool-7742-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=2
[junit4] 2> 491412 DEBUG (ScheduledTrigger-7743-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 46
[junit4] 2> 491413 DEBUG (simCloudManagerPool-7742-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 2
[junit4] 2> 491431 DEBUG (simCloudManagerPool-7742-thread-2) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=3
[junit4] 2> 491432 DEBUG (simCloudManagerPool-7742-thread-2) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 3
[junit4] 2> 491432 DEBUG (simCloudManagerPool-7742-thread-2) [ ] o.a.s.c.a.s.SimClusterStateProvider Running leader election (testCollection / shard1)
[junit4] 2> 491432 DEBUG (ScheduledTrigger-7743-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 491433 DEBUG (simCloudManagerPool-7742-thread-2) [ ] o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for testCollection / shard1 (currentVersion=4): {"core_node1":{
[junit4] 2> "core":"testCollection_shard1_replica_n1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testCollection",
[junit4] 2> "node_name":"127.0.0.1:10023_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "leader":"true",
[junit4] 2> "SEARCHER.searcher.maxDoc":0,
[junit4] 2> "SEARCHER.searcher.deletedDocs":0,
[junit4] 2> "INDEX.sizeInBytes":10240,
[junit4] 2> "state":"active",
[junit4] 2> "INDEX.sizeInGB":9.5367431640625E-6,
[junit4] 2> "SEARCHER.searcher.numDocs":0}}
[junit4] 2> 491446 DEBUG (simCloudManagerPool-7742-thread-3) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=4
[junit4] 2> 491447 DEBUG (simCloudManagerPool-7742-thread-3) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 4
[junit4] 2> 491453 DEBUG (ScheduledTrigger-7743-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 491457 DEBUG (simCloudManagerPool-7742-thread-4) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=5
[junit4] 2> 491458 DEBUG (simCloudManagerPool-7742-thread-4) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 5
[junit4] 2> 491458 DEBUG (simCloudManagerPool-7742-thread-4) [ ] o.a.s.c.a.s.SimClusterStateProvider Running leader election (testCollection / shard2)
[junit4] 2> 491458 DEBUG (simCloudManagerPool-7742-thread-4) [ ] o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for testCollection / shard2 (currentVersion=6): {"core_node3":{
[junit4] 2> "core":"testCollection_shard2_replica_n3",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"testCollection",
[junit4] 2> "node_name":"127.0.0.1:10066_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "leader":"true",
[junit4] 2> "SEARCHER.searcher.maxDoc":0,
[junit4] 2> "SEARCHER.searcher.deletedDocs":0,
[junit4] 2> "INDEX.sizeInBytes":10240,
[junit4] 2> "state":"active",
[junit4] 2> "INDEX.sizeInGB":9.5367431640625E-6,
[junit4] 2> "SEARCHER.searcher.numDocs":0}}
[junit4] 2> 491458 DEBUG (simCloudManagerPool-7742-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider -- finished createCollection testCollection, currentVersion=6
[junit4] 2> 491458 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 4. WaitCollection collection=testCollection&shards=2&replicas=2
[junit4] 2> 491458 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario WaitCollection collection=testCollection&shards=2&replicas=2
[junit4] 2> 491468 DEBUG (simCloudManagerPool-7742-thread-5) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=6
[junit4] 2> 491469 DEBUG (simCloudManagerPool-7742-thread-5) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 6
[junit4] 2> 491469 DEBUG (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=7
[junit4] 2> 491469 DEBUG (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 7
[junit4] 2> 491470 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 5. RunSolrRequest path=/admin/autoscaling&httpMethod=POST&stream.body={'set-trigger':{'name':'indexSizeTrigger','event':'indexSize','waitFor':'10s','aboveDocs':1000,'enabled':true,'actions':[{'name':'compute_plan','class':'solr.ComputePlanAction'},{'name':'execute_plan','class':'solr.ExecutePlanAction'}]}}
[junit4] 2> 491470 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario RunSolrRequest path=/admin/autoscaling&httpMethod=POST&stream.body={'set-trigger':{'name':'indexSizeTrigger','event':'indexSize','waitFor':'10s','aboveDocs':1000,'enabled':true,'actions':[{'name':'compute_plan','class':'solr.ComputePlanAction'},{'name':'execute_plan','class':'solr.ExecutePlanAction'}]}}
[junit4] 2> 491473 DEBUG (ScheduledTrigger-7743-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 491483 DEBUG (simCloudManagerPool-7742-thread-6) [ ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 491483 DEBUG (simCloudManagerPool-7742-thread-6) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 3
[junit4] 2> 491484 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 3
[junit4] 2> 491484 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 6. SetEventListener trigger=indexSizeTrigger&stage=SUCCEEDED
[junit4] 2> 491484 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario SetEventListener trigger=indexSizeTrigger&stage=SUCCEEDED
[junit4] 2> 491484 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
[junit4] 2> 491484 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion 3
[junit4] 2> 491484 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 7. IndexDocs collection=testCollection&numDocs=3000
[junit4] 2> 491484 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario IndexDocs collection=testCollection&numDocs=3000
[junit4] 2> 491489 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 8. RunSimulator
[junit4] 2> 491489 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario RunSimulator
[junit4] 2> 491493 DEBUG (ScheduledTrigger-7743-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 491513 DEBUG (ScheduledTrigger-7743-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 491533 DEBUG (ScheduledTrigger-7743-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 491553 DEBUG (ScheduledTrigger-7743-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 491574 DEBUG (ScheduledTrigger-7743-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 491594 DEBUG (ScheduledTrigger-7743-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 491614 DEBUG (ScheduledTrigger-7743-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 491635 DEBUG (ScheduledTrigger-7743-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 491655 DEBUG (ScheduledTrigger-7743-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 491675 DEBUG (ScheduledTrigger-7743-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 491695 DEBUG (ScheduledTrigger-7743-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 491715 DEBUG (ScheduledTrigger-7743-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 491720 DEBUG (ScheduledTrigger-7743-thread-1) [ ] o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown inactive - processing event: {
[junit4] 2> "id":"665ccd1968d1dT9jjvycqa5mqm0vii1kpjelavs",
[junit4] 2> "source":"indexSizeTrigger",
[junit4] 2> "eventTime":1800780224302365,
[junit4] 2> "eventType":"INDEXSIZE",
[junit4] 2> "properties":{
[junit4] 2> "aboveSize":{
[junit4] 2> "testCollection_shard1_replica_n1":"docs=1500, bytes=3082240",
[junit4] 2> "testCollection_shard2_replica_n3":"docs=1500, bytes=3082240"},
[junit4] 2> "belowSize":{},
[junit4] 2> "requestedOps":[
[junit4] 2> {
[junit4] 2> "action":"SPLITSHARD",
[junit4] 2> "hints":{
[junit4] 2> "COLL_SHARD":[{
[junit4] 2> "first":"testCollection",
[junit4] 2> "second":"shard1"}],
[junit4] 2> "PARAMS":{
[junit4] 2> "splitByPrefix":false,
[junit4] 2> "splitMethod":"link"}}},
[junit4] 2> {
[junit4] 2> "action":"SPLITSHARD",
[junit4] 2> "hints":{
[junit4] 2> "COLL_SHARD":[{
[junit4] 2> "first":"testCollection",
[junit4] 2> "second":"shard2"}],
[junit4] 2> "PARAMS":{
[junit4] 2> "splitByPrefix":false,
[junit4] 2> "splitMethod":"link"}}}]}}
[junit4] 2> 491720 DEBUG (ScheduledTrigger-7743-thread-1) [ ] o.a.s.c.a.ScheduledTriggers Pausing all triggers: [.auto_add_replicas, .scheduled_maintenance, indexSizeTrigger]
[junit4] 2> 491720 DEBUG (ScheduledTrigger-7743-thread-1) [ ] o.a.s.c.a.SystemLogListener Collection .system missing, skip sending event {
[junit4] 2> "id":"665ccd1968d1dT9jjvycqa5mqm0vii1kpjelavs",
[junit4] 2> "source":"indexSizeTrigger",
[junit4] 2> "eventTime":1800780224302365,
[junit4] 2> "eventType":"INDEXSIZE",
[junit4] 2> "properties":{
[junit4] 2> "aboveSize":{
[junit4] 2> "testCollection_shard1_replica_n1":"docs=1500, bytes=3082240",
[junit4] 2> "testCollection_shard2_replica_n3":"docs=1500, bytes=3082240"},
[junit4] 2> "belowSize":{},
[junit4] 2> "_enqueue_time_":1800790738451365,
[junit4] 2> "requestedOps":[
[junit4] 2> {
[junit4] 2> "action":"SPLITSHARD",
[junit4] 2> "hints":{
[junit4] 2> "COLL_SHARD":[{
[junit4] 2> "first":"testCollection",
[junit4] 2> "second":"shard1"}],
[junit4] 2> "PARAMS":{
[junit4] 2> "splitByPrefix":false,
[junit4] 2> "splitMethod":"link"}}},
[junit4] 2> {
[junit4] 2> "action":"SPLITSHARD",
[junit4] 2> "hints":{
[junit4] 2> "COLL_SHARD":[{
[junit4] 2> "first":"testCollection",
[junit4] 2> "second":"shard2"}],
[junit4] 2> "PARAMS":{
[junit4] 2> "splitByPrefix":false,
[junit4] 2> "splitMethod":"link"}}}]}}
[junit4] 2> 491721 DEBUG (AutoscalingActionExecutor-7744-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -- processing actions for {
[junit4] 2> "id":"665ccd1968d1dT9jjvycqa5mqm0vii1kpjelavs",
[junit4] 2> "source":"indexSizeTrigger",
[junit4] 2> "eventTime":1800780224302365,
[junit4] 2> "eventType":"INDEXSIZE",
[junit4] 2> "properties":{
[junit4] 2> "aboveSize":{
[junit4] 2> "testCollection_shard1_replica_n1":"docs=1500, bytes=3082240",
[junit4] 2> "testCollection_shard2_replica_n3":"docs=1500, bytes=3082240"},
[junit4] 2> "belowSize":{},
[junit4] 2> "_enqueue_time_":1800790738451365,
[junit4] 2> "requestedOps":[
[junit4] 2> {
[junit4] 2> "action":"SPLITSHARD",
[junit4] 2> "hints":{
[junit4] 2> "COLL_SHARD":[{
[junit4] 2> "first":"testCollection",
[junit4] 2> "second":"shard1"}],
[junit4] 2> "PARAMS":{
[junit4] 2> "splitByPrefix":false,
[junit4] 2> "splitMethod":"link"}}},
[junit4] 2> {
[junit4] 2> "action":"SPLITSHARD",
[junit4] 2> "hints":{
[junit4] 2> "COLL_SHARD":[{
[junit4] 2> "first":"testCollection",
[junit4] 2> "second":"shard2"}],
[junit4] 2> "PARAMS":{
[junit4] 2> "splitByPrefix":false,
[junit4] 2> "splitMethod":"link"}}}]}}
[junit4] 2> 491721 DEBUG (AutoscalingActionExecutor-7744-thread-1) [ ] o.a.s.c.a.ComputePlanAction -- processing event: {
[junit4] 2> "id":"665ccd1968d1dT9jjvycqa5mqm0vii1kpjelavs",
[junit4] 2> "source":"indexSizeTrigger",
[junit4] 2> "eventTime":1800780224302365,
[junit4] 2> "eventType":"INDEXSIZE",
[junit4] 2> "properties":{
[junit4] 2> "aboveSize":{
[junit4] 2> "testCollection_shard1_replica_n1":"docs=1500, bytes=3082240",
[junit4] 2> "testCollection_shard2_replica_n3":"docs=1500, bytes=3082240"},
[junit4] 2> "belowSize":{},
[junit4] 2> "_enqueue_time_":1800790738451365,
[junit4] 2> "requestedOps":[
[junit4] 2> {
[junit4] 2> "action":"SPLITSHARD",
[junit4] 2> "hints":{
[junit4] 2> "COLL_SHARD":[{
[junit4] 2> "first":"testCollection",
[junit4] 2> "second":"shard1"}],
[junit4] 2> "PARAMS":{
[junit4] 2> "splitByPrefix":false,
[junit4] 2> "splitMethod":"link"}}},
[junit4] 2> {
[junit4] 2> "action":"SPLITSHARD",
[junit4] 2> "hints":{
[junit4] 2> "COLL_SHARD":[{
[junit4] 2> "first":"testCollection",
[junit4] 2> "second":"shard2"}],
[junit4] 2> "PARAMS":{
[junit4] 2> "splitByPrefix":false,
[junit4] 2> "splitMethod":"link"}}}]}} with context properties: {BEFORE_ACTION=[compute_plan]}
[junit4] 2> 491722 DEBUG (AutoscalingActionExecutor-7744-thread-1) [ ] o.a.s.c.a.ComputePlanAction Computed Plan: action=SPLITSHARD&collection=testCollection&shard=shard1&splitMethod=link&splitByPrefix=false
[junit4] 2> 491723 DEBUG (AutoscalingActionExecutor-7744-thread-1) [ ] o.a.s.c.a.ComputePlanAction Computed Plan: action=SPLITSHARD&collection=testCollection&shard=shard2&splitMethod=link&splitByPrefix=false
[junit4] 2> 491723 DEBUG (AutoscalingActionExecutor-7744-thread-1) [ ] o.a.s.c.a.ExecutePlanAction -- processing event: {
[junit4] 2> "id":"665ccd1968d1dT9jjvycqa5mqm0vii1kpjelavs",
[junit4] 2> "source":"indexSizeTrigger",
[junit4] 2> "eventTime":1800780224302365,
[junit4] 2> "eventType":"INDEXSIZE",
[junit4] 2> "properties":{
[junit4] 2> "__start__":2,
[junit4] 2> "aboveSize":{
[junit4] 2> "testCollection_shard1_replica_n1":"docs=1500, bytes=3082240",
[junit4] 2> "testCollection_shard2_replica_n3":"docs=1500, bytes=3082240"},
[junit4] 2> "belowSize":{},
[junit4] 2> "_enqueue_time_":1800790738451365,
[junit4] 2> "requestedOps":[
[junit4] 2> {
[junit4] 2> "action":"SPLITSHARD",
[junit4] 2> "hints":{
[junit4] 2> "COLL_SHARD":[{
[junit4] 2> "first":"testCollection",
[junit4] 2> "second":"shard1"}],
[junit4] 2> "PARAMS":{
[junit4] 2> "splitByPrefix":false,
[junit4] 2> "splitMethod":"link"}}},
[junit4] 2> {
[junit4] 2> "action":"SPLITSHARD",
[junit4] 2> "hints":{
[junit4] 2> "COLL_SHARD":[{
[junit4] 2> "first":"testCollection",
[junit4] 2> "second":"shard2"}],
[junit4] 2> "PARAMS":{
[junit4] 2> "splitByPrefix":false,
[junit4] 2> "splitMethod":"link"}}}]}} with context properties: {operations=[{
[junit4] 2> "class":"org.apache.solr.client.solrj.request.CollectionAdminRequest$SplitShard",
[junit4] 2> "method":"GET",
[junit4] 2> "params.action":"SPLITSHARD",
[junit4] 2> "params.collection":"testCollection",
[junit4] 2> "params.shard":"shard1",
[junit4] 2> "params.splitMethod":"link",
[junit4] 2> "params.splitByPrefix":"false"}, {
[junit4] 2> "class":"org.apache.solr.client.solrj.request.CollectionAdminRequest$SplitShard",
[junit4] 2> "method":"GET",
[junit4] 2> "params.action":"SPLITSHARD",
[junit4] 2> "params.collection":"testCollection",
[junit4] 2> "params.shard":"shard2",
[junit4] 2> "params.splitMethod":"link",
[junit4] 2> "params.splitByPrefix":"false"}], AFTER_ACTION=[compute_plan], BEFORE_ACTION=[compute_plan, execute_plan]}
[junit4] 2> 491723 DEBUG (AutoscalingActionExecutor-7744-thread-1) [ ] o.a.s.c.a.ExecutePlanAction Executing operation: action=SPLITSHARD&collection=testCollection&shard=shard1&splitMethod=link&splitByPrefix=false
[junit4] 2> 491824 INFO (simCloudManagerPool-7742-thread-8) [ ] o.a.s.c.a.c.SplitShardCmd numSubShards set at: 2
[junit4] 2> 491867 DEBUG (simCloudManagerPool-7742-thread-8) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=8
[junit4] 2> 491867 DEBUG (simCloudManagerPool-7742-thread-8) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 8
[junit4] 2> 491869 DEBUG (simCloudManagerPool-7742-thread-10) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=9
[junit4] 2> 491870 DEBUG (simCloudManagerPool-7742-thread-10) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 9
[junit4] 2> 491870 DEBUG (simCloudManagerPool-7742-thread-12) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=10
[junit4] 2> 491870 DEBUG (simCloudManagerPool-7742-thread-12) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 10
[junit4] 2> 491870 DEBUG (simCloudManagerPool-7742-thread-12) [ ] o.a.s.c.a.s.SimClusterStateProvider Running leader election (testCollection / shard1_0)
[junit4] 2> 491870 DEBUG (simCloudManagerPool-7742-thread-12) [ ] o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for testCollection / shard1_0 (currentVersion=11): {"core_node10":{
[junit4] 2> "core":"testCollection_shard1_0_replica_n9",
[junit4] 2> "shard":"shard1_0",
[junit4] 2> "collection":"testCollection",
[junit4] 2> "node_name":"127.0.0.1:10004_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "leader":"true",
[junit4] 2> "SEARCHER.searcher.maxDoc":750,
[junit4] 2> "SEARCHER.searcher.deletedDocs":0,
[junit4] 2> "INDEX.sizeInBytes":1556480,
[junit4] 2> "base_url":"http://127.0.0.1:10004/solr",
[junit4] 2> "state":"active",
[junit4] 2> "INDEX.sizeInGB":0.0014495849609375,
[junit4] 2> "SEARCHER.searcher.numDocs":750}}
[junit4] 2> 491870 DEBUG (simCloudManagerPool-7742-thread-11) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=11
[junit4] 2> 491871 DEBUG (simCloudManagerPool-7742-thread-11) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 11
[junit4] 2> 491871 DEBUG (simCloudManagerPool-7742-thread-11) [ ] o.a.s.c.a.s.SimClusterStateProvider Running leader election (testCollection / shard1_1)
[junit4] 2> 491871 DEBUG (simCloudManagerPool-7742-thread-11) [ ] o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for testCollection / shard1_1 (currentVersion=12): {"core_node12":{
[junit4] 2> "core":"testCollection_shard1_1_replica_n11",
[junit4] 2> "shard":"shard1_1",
[junit4] 2> "collection":"testCollection",
[junit4] 2> "node_name":"127.0.0.1:10018_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "leader":"true",
[junit4] 2> "SEARCHER.searcher.maxDoc":750,
[junit4] 2> "SEARCHER.searcher.deletedDocs":0,
[junit4] 2> "INDEX.sizeInBytes":1546240,
[junit4] 2> "base_url":"http://127.0.0.1:10018/solr",
[junit4] 2> "state":"active",
[junit4] 2> "INDEX.sizeInGB":0.0014400482177734375,
[junit4] 2> "SEARCHER.searcher.numDocs":750}}
[junit4] 2> 491871 DEBUG (simCloudManagerPool-7742-thread-8) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=12
[junit4] 2> 491871 DEBUG (simCloudManagerPool-7742-thread-8) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 12
[junit4] 2> 491873 DEBUG (AutoscalingActionExecutor-7744-thread-1) [ ] o.a.s.c.a.ExecutePlanAction Executing operation: action=SPLITSHARD&collection=testCollection&shard=shard2&splitMethod=link&splitByPrefix=false
[junit4] 2> 491873 DEBUG (simCloudManagerPool-7742-thread-15) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=13
[junit4] 2> 491874 DEBUG (simCloudManagerPool-7742-thread-15) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 13
[junit4] 2> 491974 INFO (simCloudManagerPool-7742-thread-15) [ ] o.a.s.c.a.c.SplitShardCmd numSubShards set at: 2
[junit4] 2> 492015 DEBUG (simCloudManagerPool-7742-thread-15) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=14
[junit4] 2> 492016 DEBUG (simCloudManagerPool-7742-thread-15) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 14
[junit4] 2> 492016 DEBUG (simCloudManagerPool-7742-thread-17) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=15
[junit4] 2> 492017 DEBUG (simCloudManagerPool-7742-thread-17) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 15
[junit4] 2> 492017 DEBUG (simCloudManagerPool-7742-thread-18) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=16
[junit4] 2> 492017 DEBUG (simCloudManagerPool-7742-thread-18) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 16
[junit4] 2> 492017 DEBUG (simCloudManagerPool-7742-thread-18) [ ] o.a.s.c.a.s.SimClusterStateProvider Running leader election (testCollection / shard2_1)
[junit4] 2> 492017 DEBUG (simCloudManagerPool-7742-thread-18) [ ] o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for testCollection / shard2_1 (currentVersion=17): {"core_node22":{
[junit4] 2> "core":"testCollection_shard2_1_replica_n21",
[junit4] 2> "shard":"shard2_1",
[junit4] 2> "collection":"testCollection",
[junit4] 2> "node_name":"127.0.0.1:10018_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "leader":"true",
[junit4] 2> "SEARCHER.searcher.maxDoc":750,
[junit4] 2> "SEARCHER.searcher.deletedDocs":0,
[junit4] 2> "INDEX.sizeInBytes":1546240,
[junit4] 2> "base_url":"http://127.0.0.1:10018/solr",
[junit4] 2> "state":"active",
[junit4] 2> "INDEX.sizeInGB":0.0014400482177734375,
[junit4] 2> "SEARCHER.searcher.numDocs":750}}
[junit4] 2> 492017 DEBUG (simCloudManagerPool-7742-thread-19) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=17
[junit4] 2> 492017 DEBUG (simCloudManagerPool-7742-thread-19) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 17
[junit4] 2> 492018 DEBUG (simCloudManagerPool-7742-thread-20) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=18
[junit4] 2> 492018 DEBUG (simCloudManagerPool-7742-thread-20) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 18
[junit4] 2> 492018 DEBUG (simCloudManagerPool-7742-thread-15) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=19
[junit4] 2> 492018 DEBUG (simCloudManagerPool-7742-thread-15) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 19
[junit4] 2> 492018 DEBUG (simCloudManagerPool-7742-thread-21) [ ] o.a.s.c.a.s.SimClusterStateProvider Running leader election (testCollection / shard2_0)
[junit4] 2> 492018 DEBUG (simCloudManagerPool-7742-thread-15) [ ] o.a.s.c.a.s.SimClusterStateProvider ** no leader in testCollection / shard2_0:{
[junit4] 2> "parent":"shard2",
[junit4] 2> "stateTimestamp":"1588065974203592700",
[junit4] 2> "range":"0-3fffffff",
[junit4] 2> "state":"construction",
[junit4] 2> "replicas":{
[junit4] 2> "core_node18":{
[junit4] 2> "core":"testCollection_shard2_0_replica_n17",
[junit4] 2> "SEARCHER.searcher.maxDoc":750,
[junit4] 2> "SEARCHER.searcher.deletedDocs":0,
[junit4] 2> "INDEX.sizeInBytes":1556480,
[junit4] 2> "node_name":"127.0.0.1:10082_solr",
[junit4] 2> "base_url":"http://127.0.0.1:10082/solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "INDEX.sizeInGB":0.0014495849609375,
[junit4] 2> "SEARCHER.searcher.numDocs":750},
[junit4] 2> "core_node20":{
[junit4] 2> "core":"testCollection_shard2_0_replica_n19",
[junit4] 2> "SEARCHER.searcher.maxDoc":750,
[junit4] 2> "SEARCHER.searcher.deletedDocs":0,
[junit4] 2> "INDEX.sizeInBytes":1556480,
[junit4] 2> "node_name":"127.0.0.1:10004_solr",
[junit4] 2> "base_url":"http://127.0.0.1:10004/solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "INDEX.sizeInGB":0.0014495849609375,
[junit4] 2> "SEARCHER.searcher.numDocs":750}}}
[junit4] 2> 492018 DEBUG (simCloudManagerPool-7742-thread-21) [ ] o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for testCollection / shard2_0 (currentVersion=20): {"core_node18":{
[junit4] 2> "core":"testCollection_shard2_0_replica_n17",
[junit4] 2> "shard":"shard2_0",
[junit4] 2> "collection":"testCollection",
[junit4] 2> "node_name":"127.0.0.1:10082_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "leader":"true",
[junit4] 2> "SEARCHER.searcher.maxDoc":750,
[junit4] 2> "SEARCHER.searcher.deletedDocs":0,
[junit4] 2> "INDEX.sizeInBytes":1556480,
[junit4] 2> "base_url":"http://127.0.0.1:10082/solr",
[junit4] 2> "state":"active",
[junit4] 2> "INDEX.sizeInGB":0.0014495849609375,
[junit4] 2> "SEARCHER.searcher.numDocs":750}}
[junit4] 2> 492020 DEBUG (simCloudManagerPool-7742-thread-15) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=20
[junit4] 2> 492020 DEBUG (simCloudManagerPool-7742-thread-15) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 20
[junit4] 2> 492021 DEBUG (AutoscalingActionExecutor-7744-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=21
[junit4] 2> 492021 DEBUG (AutoscalingActionExecutor-7744-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 21
[junit4] 2> 492021 DEBUG (AutoscalingActionExecutor-7744-thread-1) [ ] o.a.s.c.a.SystemLogListener Collection .system missing, skip sending event {
[junit4] 2> "id":"665ccd1968d1dT9jjvycqa5mqm0vii1kpjelavs",
[junit4] 2> "source":"indexSizeTrigger",
[junit4] 2> "eventTime":1800780224302365,
[junit4] 2> "eventType":"INDEXSIZE",
[junit4] 2> "properties":{
[junit4] 2> "__start__":2,
[junit4] 2> "aboveSize":{
[junit4] 2> "testCollection_shard1_replica_n1":"docs=1500, bytes=3082240",
[junit4] 2> "testCollection_shard2_replica_n3":"docs=1500, bytes=3082240"},
[junit4] 2> "belowSize":{},
[junit4] 2> "_enqueue_time_":1800790738451365,
[junit4] 2> "requestedOps":[
[junit4] 2> {
[junit4] 2> "action":"SPLITSHARD",
[junit4] 2> "hints":{
[junit4] 2> "COLL_SHARD":[{
[junit4] 2> "first":"testCollection",
[junit4] 2> "second":"shard1"}],
[junit4] 2> "PARAMS":{
[junit4] 2> "splitByPrefix":false,
[junit4] 2> "splitMethod":"link"}}},
[junit4] 2> {
[junit4] 2> "action":"SPLITSHARD",
[junit4] 2> "hints":{
[junit4] 2> "COLL_SHARD":[{
[junit4] 2> "first":"testCollection",
[junit4] 2> "second":"shard2"}],
[junit4] 2> "PARAMS":{
[junit4] 2> "splitByPrefix":false,
[junit4] 2> "splitMethod":"link"}}}]}}
[junit4] 2> 492022 DEBUG (AutoscalingActionExecutor-7744-thread-1) [ ] o.a.s.c.a.ScheduledTriggers Resuming trigger: indexSizeTrigger after 100ms
[junit4] 2> 492022 DEBUG (AutoscalingActionExecutor-7744-thread-1) [ ] o.a.s.c.a.ScheduledTriggers Resuming trigger: .scheduled_maintenance after 100ms
[junit4] 2> 492022 DEBUG (AutoscalingActionExecutor-7744-thread-1) [ ] o.a.s.c.a.ScheduledTriggers Resuming trigger: .auto_add_replicas after 100ms
[junit4] 2> 492022 DEBUG (AutoscalingActionExecutor-7744-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -- processing took 15050 ms for event id=665ccd1968d1dT9jjvycqa5mqm0vii1kpjelavs
[junit4] 2> 492122 DEBUG (ScheduledTrigger-7743-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492142 DEBUG (ScheduledTrigger-7743-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492162 DEBUG (ScheduledTrigger-7743-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492182 DEBUG (ScheduledTrigger-7743-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492202 DEBUG (ScheduledTrigger-7743-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492223 DEBUG (ScheduledTrigger-7743-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492243 DEBUG (ScheduledTrigger-7743-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492263 DEBUG (ScheduledTrigger-7743-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492283 DEBUG (ScheduledTrigger-7743-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492303 DEBUG (ScheduledTrigger-7743-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492323 DEBUG (ScheduledTrigger-7743-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492344 DEBUG (ScheduledTrigger-7743-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492364 DEBUG (ScheduledTrigger-7743-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492384 DEBUG (ScheduledTrigger-7743-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492404 DEBUG (ScheduledTrigger-7743-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492424 DEBUG (ScheduledTrigger-7743-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492445 DEBUG (ScheduledTrigger-7743-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492465 DEBUG (ScheduledTrigger-7743-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492485 DEBUG (ScheduledTrigger-7743-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492505 DEBUG (ScheduledTrigger-7743-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492525 DEBUG (ScheduledTrigger-7743-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492545 DEBUG (ScheduledTrigger-7743-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492566 DEBUG (ScheduledTrigger-7743-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492586 DEBUG (ScheduledTrigger-7743-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492606 DEBUG (ScheduledTrigger-7743-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492626 DEBUG (ScheduledTrigger-7743-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492646 DEBUG (ScheduledTrigger-7743-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492666 DEBUG (ScheduledTrigger-7743-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492687 DEBUG (ScheduledTrigger-7743-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 100 and last live nodes: 100
[junit4] 2> 492689 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 9. WaitEvent trigger=indexSizeTrigger&wait=60
[junit4] 2> 492690 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario WaitEvent trigger=indexSizeTrigger&wait=60
[junit4] 2> 492690 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 10. Assert condition=not_null&key=_trigger_event_indexSizeTrigger
[junit4] 2> 492691 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario Assert condition=not_null&key=_trigger_event_indexSizeTrigger
[junit4] 2> 492692 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 11. Assert condition=equals&key=_trigger_event_indexSizeTrigger/eventType&expected=INDEXSIZE
[junit4] 2> 492692 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario Assert condition=equals&key=_trigger_event_indexSizeTrigger/eventType&expected=INDEXSIZE
[junit4] 2> 492692 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 12. Assert condition=equals&key=_trigger_event_indexSizeTrigger/properties/requestedOps[0]/action&expected=SPLITSHARD
[junit4] 2> 492692 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario Assert condition=equals&key=_trigger_event_indexSizeTrigger/properties/requestedOps[0]/action&expected=SPLITSHARD
[junit4] 2> 492692 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 13. WaitCollection collection=testCollection&shards=6&withInactive=true&requireLeaders=false&replicas=2
[junit4] 2> 492692 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario WaitCollection collection=testCollection&shards=6&withInactive=true&requireLeaders=false&replicas=2
[junit4] 2> 492693 DEBUG (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.ScheduledTriggers Shutting down scheduled thread pool executor now
[junit4] 2> 492693 WARN (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Interrupted
[junit4] 2> => java.lang.InterruptedException
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014)
[junit4] 2> java.lang.InterruptedException: null
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014) ~[?:1.8.0_201]
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2048) ~[?:1.8.0_201]
[junit4] 2> at org.apache.solr.cloud.autoscaling.OverseerTriggerThread.run(OverseerTriggerThread.java:209) ~[java/:?]
[junit4] 2> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_201]
[junit4] 2> 492693 DEBUG (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.ScheduledTriggers Shutting down action executor now
[junit4] 2> 492693 DEBUG (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.ScheduledTriggers Awaiting termination for action executor
[junit4] 2> 492693 DEBUG (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.ScheduledTriggers Awaiting termination for scheduled thread pool executor
[junit4] 2> 492695 DEBUG (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.ScheduledTriggers ScheduledTriggers closed completely
[junit4] 2> 492695 DEBUG (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
[junit4] 2> 492696 INFO (TEST-TestSimScenario.testIndexing-seed#[6E71CCF15FED0624]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testIndexing
[junit4] 2> 492698 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSplitShard
[junit4] 2> 492699 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 1. CreateCluster numNodes=2
[junit4] 2> 492699 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario CreateCluster numNodes=2
[junit4] 2> 492703 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimClusterStateProvider --- new Overseer leader: 127.0.0.1:10100_solr
[junit4] 2> 492704 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=0
[junit4] 2> 492704 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 0
[junit4] 2> 492704 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 492704 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 2. LoadAutoscaling json={'cluster-policy':[]}
[junit4] 2> 492704 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers
[junit4] 2> 492704 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario LoadAutoscaling json={'cluster-policy':[]}
[junit4] 2> 492704 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 2
[junit4] 2> 492704 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 0
[junit4] 2> 492704 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
[junit4] 2> 492705 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:10100_solr, 127.0.0.1:10101_solr]
[junit4] 2> 492705 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
[junit4] 2> 492705 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
[junit4] 2> 492705 DEBUG (ScheduledTrigger-7749-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 492709 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 3. RunSolrRequest path=/admin/collections&action=CREATE&name=testCollection&numShards=2&replicationFactor=2&maxShardsPerNode=5
[junit4] 2> 492709 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario RunSolrRequest path=/admin/collections&action=CREATE&name=testCollection&numShards=2&replicationFactor=2&maxShardsPerNode=5
[junit4] 2> 492710 DEBUG (simCloudManagerPool-7748-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider -- simCreateCollection testCollection, currentVersion=1
[junit4] 2> 492710 DEBUG (simCloudManagerPool-7748-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=1
[junit4] 2> 492710 DEBUG (simCloudManagerPool-7748-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 1
[junit4] 2> 492720 DEBUG (simCloudManagerPool-7748-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=2
[junit4] 2> 492720 DEBUG (simCloudManagerPool-7748-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 2
[junit4] 2> 492725 DEBUG (ScheduledTrigger-7749-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 492731 DEBUG (simCloudManagerPool-7748-thread-3) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=3
[junit4] 2> 492732 DEBUG (simCloudManagerPool-7748-thread-3) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 3
[junit4] 2> 492732 DEBUG (simCloudManagerPool-7748-thread-3) [ ] o.a.s.c.a.s.SimClusterStateProvider Running leader election (testCollection / shard1)
[junit4] 2> 492732 DEBUG (simCloudManagerPool-7748-thread-3) [ ] o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for testCollection / shard1 (currentVersion=4): {"core_node2":{
[junit4] 2> "core":"testCollection_shard1_replica_n2",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testCollection",
[junit4] 2> "node_name":"127.0.0.1:10100_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "leader":"true",
[junit4] 2> "SEARCHER.searcher.maxDoc":0,
[junit4] 2> "SEARCHER.searcher.deletedDocs":0,
[junit4] 2> "INDEX.sizeInBytes":10240,
[junit4] 2> "state":"active",
[junit4] 2> "INDEX.sizeInGB":9.5367431640625E-6,
[junit4] 2> "SEARCHER.searcher.numDocs":0}}
[junit4] 2> 492742 DEBUG (simCloudManagerPool-7748-thread-2) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=4
[junit4] 2> 492742 DEBUG (simCloudManagerPool-7748-thread-2) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 4
[junit4] 2> 492742 DEBUG (simCloudManagerPool-7748-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider -- finished createCollection testCollection, currentVersion=5
[junit4] 2> 492742 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 4. WaitCollection collection=testCollection&shards=2&replicas=2
[junit4] 2> 492742 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario WaitCollection collection=testCollection&shards=2&replicas=2
[junit4] 2> 492745 DEBUG (ScheduledTrigger-7749-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 492752 DEBUG (simCloudManagerPool-7748-thread-5) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=5
[junit4] 2> 492753 DEBUG (simCloudManagerPool-7748-thread-5) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 5
[junit4] 2> 492753 DEBUG (simCloudManagerPool-7748-thread-5) [ ] o.a.s.c.a.s.SimClusterStateProvider Running leader election (testCollection / shard2)
[junit4] 2> 492753 DEBUG (simCloudManagerPool-7748-thread-5) [ ] o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for testCollection / shard2 (currentVersion=6): {"core_node4":{
[junit4] 2> "core":"testCollection_shard2_replica_n4",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"testCollection",
[junit4] 2> "node_name":"127.0.0.1:10100_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "leader":"true",
[junit4] 2> "SEARCHER.searcher.maxDoc":0,
[junit4] 2> "SEARCHER.searcher.deletedDocs":0,
[junit4] 2> "INDEX.sizeInBytes":10240,
[junit4] 2> "state":"active",
[junit4] 2> "INDEX.sizeInGB":9.5367431640625E-6,
[junit4] 2> "SEARCHER.searcher.numDocs":0}}
[junit4] 2> 492763 DEBUG (simCloudManagerPool-7748-thread-4) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=6
[junit4] 2> 492764 DEBUG (simCloudManagerPool-7748-thread-4) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 6
[junit4] 2> 492764 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=7
[junit4] 2> 492764 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 7
[junit4] 2> 492764 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 5. SetShardMetrics collection=testCollection&shard=shard1&INDEX.sizeInBytes=1000000000
[junit4] 2> 492764 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario SetShardMetrics collection=testCollection&shard=shard1&INDEX.sizeInBytes=1000000000
[junit4] 2> 492765 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 6. SetNodeMetrics nodeset=#ANY&freedisk=1.5
[junit4] 2> 492765 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario SetNodeMetrics nodeset=#ANY&freedisk=1.5
[junit4] 2> 492766 DEBUG (ScheduledTrigger-7749-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 492766 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 7. RunSolrRequest path=/admin/collection&action=SPLITSHARD&collection=testCollection&shard=shard1&splitMethod=${method}
[junit4] 2> 492766 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario RunSolrRequest path=/admin/collection&action=SPLITSHARD&collection=testCollection&shard=shard1&splitMethod=REWRITE
[junit4] 2> 492766 INFO (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 492766 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.ScheduledTriggers Shutting down scheduled thread pool executor now
[junit4] 2> 492767 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.ScheduledTriggers Shutting down action executor now
[junit4] 2> 492767 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.ScheduledTriggers Awaiting termination for action executor
[junit4] 2> 492767 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.ScheduledTriggers Awaiting termination for scheduled thread pool executor
[junit4] 2> 492767 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.ScheduledTriggers ScheduledTriggers closed completely
[junit4] 2> 492767 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
[junit4] 2> 492767 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 1. CreateCluster numNodes=2
[junit4] 2> 492767 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario CreateCluster numNodes=2
[junit4] 2> 492769 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimClusterStateProvider --- new Overseer leader: 127.0.0.1:10102_solr
[junit4] 2> 492769 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=0
[junit4] 2> 492769 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 0
[junit4] 2> 492769 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 492769 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 2. LoadAutoscaling json={'cluster-policy':[]}
[junit4] 2> 492769 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario LoadAutoscaling json={'cluster-policy':[]}
[junit4] 2> 492769 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers
[junit4] 2> 492769 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 2
[junit4] 2> 492769 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 0
[junit4] 2> 492769 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
[junit4] 2> 492769 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:10102_solr, 127.0.0.1:10103_solr]
[junit4] 2> 492770 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
[junit4] 2> 492770 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
[junit4] 2> 492770 DEBUG (ScheduledTrigger-7755-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 492774 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 3. RunSolrRequest path=/admin/collections&action=CREATE&name=testCollection&numShards=2&replicationFactor=2&maxShardsPerNode=5
[junit4] 2> 492774 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario RunSolrRequest path=/admin/collections&action=CREATE&name=testCollection&numShards=2&replicationFactor=2&maxShardsPerNode=5
[junit4] 2> 492774 DEBUG (simCloudManagerPool-7754-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider -- simCreateCollection testCollection, currentVersion=1
[junit4] 2> 492775 DEBUG (simCloudManagerPool-7754-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=1
[junit4] 2> 492775 DEBUG (simCloudManagerPool-7754-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 1
[junit4] 2> 492785 DEBUG (simCloudManagerPool-7754-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=2
[junit4] 2> 492785 DEBUG (simCloudManagerPool-7754-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 2
[junit4] 2> 492790 DEBUG (ScheduledTrigger-7755-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 492795 DEBUG (simCloudManagerPool-7754-thread-2) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=3
[junit4] 2> 492796 DEBUG (simCloudManagerPool-7754-thread-2) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 3
[junit4] 2> 492796 DEBUG (simCloudManagerPool-7754-thread-2) [ ] o.a.s.c.a.s.SimClusterStateProvider Running leader election (testCollection / shard1)
[junit4] 2> 492796 DEBUG (simCloudManagerPool-7754-thread-2) [ ] o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for testCollection / shard1 (currentVersion=4): {"core_node1":{
[junit4] 2> "core":"testCollection_shard1_replica_n1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testCollection",
[junit4] 2> "node_name":"127.0.0.1:10102_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "leader":"true",
[junit4] 2> "SEARCHER.searcher.maxDoc":0,
[junit4] 2> "SEARCHER.searcher.deletedDocs":0,
[junit4] 2> "INDEX.sizeInBytes":10240,
[junit4] 2> "state":"active",
[junit4] 2> "INDEX.sizeInGB":9.5367431640625E-6,
[junit4] 2> "SEARCHER.searcher.numDocs":0}}
[junit4] 2> 492806 DEBUG (simCloudManagerPool-7754-thread-3) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=4
[junit4] 2> 492806 DEBUG (simCloudManagerPool-7754-thread-3) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 4
[junit4] 2> 492806 DEBUG (simCloudManagerPool-7754-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider -- finished createCollection testCollection, currentVersion=5
[junit4] 2> 492806 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 4. WaitCollection collection=testCollection&shards=2&replicas=2
[junit4] 2> 492806 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario WaitCollection collection=testCollection&shards=2&replicas=2
[junit4] 2> 492810 DEBUG (ScheduledTrigger-7755-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 492816 DEBUG (simCloudManagerPool-7754-thread-4) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=5
[junit4] 2> 492817 DEBUG (simCloudManagerPool-7754-thread-4) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 5
[junit4] 2> 492817 DEBUG (simCloudManagerPool-7754-thread-4) [ ] o.a.s.c.a.s.SimClusterStateProvider Running leader election (testCollection / shard2)
[junit4] 2> 492817 DEBUG (simCloudManagerPool-7754-thread-4) [ ] o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for testCollection / shard2 (currentVersion=6): {"core_node3":{
[junit4] 2> "core":"testCollection_shard2_replica_n3",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"testCollection",
[junit4] 2> "node_name":"127.0.0.1:10102_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "leader":"true",
[junit4] 2> "SEARCHER.searcher.maxDoc":0,
[junit4] 2> "SEARCHER.searcher.deletedDocs":0,
[junit4] 2> "INDEX.sizeInBytes":10240,
[junit4] 2> "state":"active",
[junit4] 2> "INDEX.sizeInGB":9.5367431640625E-6,
[junit4] 2> "SEARCHER.searcher.numDocs":0}}
[junit4] 2> 492827 DEBUG (simCloudManagerPool-7754-thread-5) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=6
[junit4] 2> 492827 DEBUG (simCloudManagerPool-7754-thread-5) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 6
[junit4] 2> 492827 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=7
[junit4] 2> 492828 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 7
[junit4] 2> 492828 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 5. SetShardMetrics collection=testCollection&shard=shard1&INDEX.sizeInBytes=1000000000
[junit4] 2> 492828 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario SetShardMetrics collection=testCollection&shard=shard1&INDEX.sizeInBytes=1000000000
[junit4] 2> 492828 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 6. SetNodeMetrics nodeset=#ANY&freedisk=1.5
[junit4] 2> 492828 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario SetNodeMetrics nodeset=#ANY&freedisk=1.5
[junit4] 2> 492828 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 7. RunSolrRequest path=/admin/collection&action=SPLITSHARD&collection=testCollection&shard=shard1&splitMethod=${method}
[junit4] 2> 492828 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario RunSolrRequest path=/admin/collection&action=SPLITSHARD&collection=testCollection&shard=shard1&splitMethod=LINK
[junit4] 2> 492830 DEBUG (ScheduledTrigger-7755-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 492850 DEBUG (ScheduledTrigger-7755-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 492871 DEBUG (ScheduledTrigger-7755-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 492891 DEBUG (ScheduledTrigger-7755-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 492911 DEBUG (ScheduledTrigger-7755-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 492928 INFO (simCloudManagerPool-7754-thread-6) [ ] o.a.s.c.a.c.SplitShardCmd numSubShards set at: 2
[junit4] 2> 492931 DEBUG (ScheduledTrigger-7755-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 492951 DEBUG (ScheduledTrigger-7755-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 492969 DEBUG (simCloudManagerPool-7754-thread-6) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=8
[junit4] 2> 492970 DEBUG (simCloudManagerPool-7754-thread-6) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 8
[junit4] 2> 492970 DEBUG (simCloudManagerPool-7754-thread-8) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=9
[junit4] 2> 492971 DEBUG (ScheduledTrigger-7755-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 492976 DEBUG (simCloudManagerPool-7754-thread-8) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 9
[junit4] 2> 492976 DEBUG (simCloudManagerPool-7754-thread-9) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=10
[junit4] 2> 492977 DEBUG (simCloudManagerPool-7754-thread-9) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 10
[junit4] 2> 492977 DEBUG (simCloudManagerPool-7754-thread-9) [ ] o.a.s.c.a.s.SimClusterStateProvider Running leader election (testCollection / shard1_1)
[junit4] 2> 492977 DEBUG (simCloudManagerPool-7754-thread-9) [ ] o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for testCollection / shard1_1 (currentVersion=11): {"core_node12":{
[junit4] 2> "core":"testCollection_shard1_1_replica_n11",
[junit4] 2> "shard":"shard1_1",
[junit4] 2> "collection":"testCollection",
[junit4] 2> "node_name":"127.0.0.1:10102_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "leader":"true",
[junit4] 2> "SEARCHER.searcher.maxDoc":0,
[junit4] 2> "SEARCHER.searcher.deletedDocs":0,
[junit4] 2> "INDEX.sizeInBytes":10240,
[junit4] 2> "base_url":"http://127.0.0.1:10102/solr",
[junit4] 2> "state":"active",
[junit4] 2> "INDEX.sizeInGB":9.5367431640625E-6,
[junit4] 2> "SEARCHER.searcher.numDocs":0}}
[junit4] 2> 492977 DEBUG (simCloudManagerPool-7754-thread-6) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=11
[junit4] 2> 492977 DEBUG (simCloudManagerPool-7754-thread-6) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 11
[junit4] 2> 492977 DEBUG (simCloudManagerPool-7754-thread-10) [ ] o.a.s.c.a.s.SimClusterStateProvider Running leader election (testCollection / shard1_0)
[junit4] 2> 492977 DEBUG (simCloudManagerPool-7754-thread-6) [ ] o.a.s.c.a.s.SimClusterStateProvider ** no leader in testCollection / shard1_0:{
[junit4] 2> "parent":"shard1",
[junit4] 2> "stateTimestamp":"1588066021902687800",
[junit4] 2> "range":"80000000-bfffffff",
[junit4] 2> "state":"construction",
[junit4] 2> "replicas":{
[junit4] 2> "core_node10":{
[junit4] 2> "core":"testCollection_shard1_0_replica_n9",
[junit4] 2> "SEARCHER.searcher.maxDoc":0,
[junit4] 2> "SEARCHER.searcher.deletedDocs":0,
[junit4] 2> "INDEX.sizeInBytes":20480,
[junit4] 2> "node_name":"127.0.0.1:10103_solr",
[junit4] 2> "base_url":"http://127.0.0.1:10103/solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "INDEX.sizeInGB":1.9073486328125E-5,
[junit4] 2> "SEARCHER.searcher.numDocs":0},
[junit4] 2> "core_node8":{
[junit4] 2> "core":"testCollection_shard1_0_replica_n7",
[junit4] 2> "SEARCHER.searcher.maxDoc":0,
[junit4] 2> "SEARCHER.searcher.deletedDocs":0,
[junit4] 2> "INDEX.sizeInBytes":20480,
[junit4] 2> "node_name":"127.0.0.1:10102_solr",
[junit4] 2> "base_url":"http://127.0.0.1:10102/solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "INDEX.sizeInGB":1.9073486328125E-5,
[junit4] 2> "SEARCHER.searcher.numDocs":0}}}
[junit4] 2> 492977 DEBUG (simCloudManagerPool-7754-thread-10) [ ] o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for testCollection / shard1_0 (currentVersion=12): {"core_node10":{
[junit4] 2> "core":"testCollection_shard1_0_replica_n9",
[junit4] 2> "shard":"shard1_0",
[junit4] 2> "collection":"testCollection",
[junit4] 2> "node_name":"127.0.0.1:10103_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "leader":"true",
[junit4] 2> "SEARCHER.searcher.maxDoc":0,
[junit4] 2> "SEARCHER.searcher.deletedDocs":0,
[junit4] 2> "INDEX.sizeInBytes":20480,
[junit4] 2> "base_url":"http://127.0.0.1:10103/solr",
[junit4] 2> "state":"active",
[junit4] 2> "INDEX.sizeInGB":1.9073486328125E-5,
[junit4] 2> "SEARCHER.searcher.numDocs":0}}
[junit4] 2> 492979 DEBUG (simCloudManagerPool-7754-thread-6) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=12
[junit4] 2> 492979 DEBUG (simCloudManagerPool-7754-thread-6) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 12
[junit4] 2> 492979 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 8. WaitCollection collection=testCollection&shards=4&withInactive=true&replicas=2&requireLeaders=true
[junit4] 2> 492979 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario WaitCollection collection=testCollection&shards=4&withInactive=true&replicas=2&requireLeaders=true
[junit4] 2> 492979 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=13
[junit4] 2> 492979 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 13
[junit4] 2> 492980 WARN (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Interrupted
[junit4] 2> => java.lang.InterruptedException
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014)
[junit4] 2> java.lang.InterruptedException: null
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014) ~[?:1.8.0_201]
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2048) ~[?:1.8.0_201]
[junit4] 2> at org.apache.solr.cloud.autoscaling.OverseerTriggerThread.run(OverseerTriggerThread.java:209) ~[java/:?]
[junit4] 2> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_201]
[junit4] 2> 492980 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.ScheduledTriggers Shutting down scheduled thread pool executor now
[junit4] 2> 492980 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.ScheduledTriggers Shutting down action executor now
[junit4] 2> 492980 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.ScheduledTriggers Awaiting termination for action executor
[junit4] 2> 492980 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.ScheduledTriggers Awaiting termination for scheduled thread pool executor
[junit4] 2> 492980 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.ScheduledTriggers ScheduledTriggers closed completely
[junit4] 2> 492980 DEBUG (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
[junit4] 2> 492981 INFO (TEST-TestSimScenario.testSplitShard-seed#[6E71CCF15FED0624]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testSplitShard
[junit4] 2> 492982 INFO (TEST-TestSimScenario.testAutoAddReplicas-seed#[6E71CCF15FED0624]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testAutoAddReplicas
[junit4] 2> 492982 INFO (TEST-TestSimScenario.testAutoAddReplicas-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 1. CreateCluster numNodes=2
[junit4] 2> 492982 INFO (TEST-TestSimScenario.testAutoAddReplicas-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario CreateCluster numNodes=2
[junit4] 2> 492984 DEBUG (TEST-TestSimScenario.testAutoAddReplicas-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimClusterStateProvider --- new Overseer leader: 127.0.0.1:10104_solr
[junit4] 2> 492984 DEBUG (TEST-TestSimScenario.testAutoAddReplicas-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=0
[junit4] 2> 492984 DEBUG (TEST-TestSimScenario.testAutoAddReplicas-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 0
[junit4] 2> 492984 INFO (TEST-TestSimScenario.testAutoAddReplicas-seed#[6E71CCF15FED0624]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 492984 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers
[junit4] 2> 492984 INFO (TEST-TestSimScenario.testAutoAddReplicas-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 2. LoadAutoscaling json={'cluster-policy'+:+[{'replica'+:+'<3',+'shard'+:+'#EACH',+'collection'+:+'testCollection','node':'#ANY'}]}&defaultWaitFor=10
[junit4] 2> 492984 INFO (TEST-TestSimScenario.testAutoAddReplicas-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario LoadAutoscaling json={'cluster-policy'+:+[{'replica'+:+'<3',+'shard'+:+'#EACH',+'collection'+:+'testCollection','node':'#ANY'}]}&defaultWaitFor=10
[junit4] 2> 492985 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1
[junit4] 2> 492985 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 0
[junit4] 2> 492985 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
[junit4] 2> 492985 DEBUG (TEST-TestSimScenario.testAutoAddReplicas-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 2
[junit4] 2> 492985 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:10104_solr, 127.0.0.1:10105_solr]
[junit4] 2> 492985 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
[junit4] 2> 492985 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 1
[junit4] 2> 492985 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
[junit4] 2> 492985 DEBUG (ScheduledTrigger-7761-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 492986 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:10104_solr, 127.0.0.1:10105_solr]
[junit4] 2> 492986 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
[junit4] 2> 492986 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
[junit4] 2> 492986 DEBUG (ScheduledTrigger-7761-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 492990 INFO (TEST-TestSimScenario.testAutoAddReplicas-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario 3. RunSolrRequest path=/admin/collections&action=CREATE&autoAddReplicas=true&name=testCollection&numShards=2&replicationFactor=2&maxShardsPerNode=2
[junit4] 2> 492990 INFO (TEST-TestSimScenario.testAutoAddReplicas-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.s.SimScenario RunSolrRequest path=/admin/collections&action=CREATE&autoAddReplicas=true&name=testCollection&numShards=2&replicationFactor=2&maxShardsPerNode=2
[junit4] 2> 492990 DEBUG (simCloudManagerPool-7760-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider -- simCreateCollection testCollection, currentVersion=1
[junit4] 2> 492990 DEBUG (simCloudManagerPool-7760-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=1
[junit4] 2> 492990 DEBUG (simCloudManagerPool-7760-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 1
[junit4] 2> 493001 DEBUG (simCloudManagerPool-7760-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=2
[junit4] 2> 493001 DEBUG (simCloudManagerPool-7760-thread-1) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 2
[junit4] 2> 493006 DEBUG (ScheduledTrigger-7761-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 493011 DEBUG (simCloudManagerPool-7760-thread-2) [ ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, currentVersion=3
[junit4] 2> 493012 DEBUG (simCloudManagerPool-7760-thread-2) [ ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 3
[junit4] 2> 493
[...truncated too long message...]
igger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 493910 DEBUG (ScheduledTrigger-7767-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 493930 DEBUG (ScheduledTrigger-7767-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 493950 DEBUG (ScheduledTrigger-7767-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 493970 DEBUG (ScheduledTrigger-7767-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 493990 DEBUG (ScheduledTrigger-7767-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 494010 DEBUG (ScheduledTrigger-7767-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 494030 DEBUG (ScheduledTrigger-7767-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 494050 DEBUG (ScheduledTrigger-7767-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 494070 DEBUG (ScheduledTrigger-7767-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 494091 DEBUG (ScheduledTrigger-7767-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 494111 DEBUG (ScheduledTrigger-7767-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 494131 DEBUG (ScheduledTrigger-7767-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 494151 DEBUG (ScheduledTrigger-7767-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 494171 DEBUG (ScheduledTrigger-7767-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 494191 DEBUG (ScheduledTrigger-7767-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 494211 DEBUG (ScheduledTrigger-7767-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 494232 DEBUG (ScheduledTrigger-7767-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 494252 DEBUG (ScheduledTrigger-7767-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 494272 DEBUG (ScheduledTrigger-7767-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 494292 DEBUG (ScheduledTrigger-7767-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 494309 INFO (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 494309 DEBUG (TEST-TestSimScenario.testSuggestions-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.ScheduledTriggers Shutting down scheduled thread pool executor now
[junit4] 2> 494309 DEBUG (TEST-TestSimScenario.testSuggestions-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.ScheduledTriggers Shutting down action executor now
[junit4] 2> 494309 DEBUG (TEST-TestSimScenario.testSuggestions-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.ScheduledTriggers Awaiting termination for action executor
[junit4] 2> 494309 DEBUG (TEST-TestSimScenario.testSuggestions-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.ScheduledTriggers Awaiting termination for scheduled thread pool executor
[junit4] 2> 494310 DEBUG (TEST-TestSimScenario.testSuggestions-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.ScheduledTriggers ScheduledTriggers closed completely
[junit4] 2> 494310 DEBUG (TEST-TestSimScenario.testSuggestions-seed#[6E71CCF15FED0624]) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
[junit4] 2> 494310 INFO (TEST-TestSimScenario.testSuggestions-seed#[6E71CCF15FED0624]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testSuggestions
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestSimScenario -Dtests.method=testSuggestions -Dtests.seed=6E71CCF15FED0624 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=zh -Dtests.timezone=America/North_Dakota/Beulah -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.61s J3 | TestSimScenario.testSuggestions <<<
[junit4] > Throwable #1: java.util.concurrent.TimeoutException: OverseerTriggerThread never caught up to the latest znodeVersion
[junit4] > at __randomizedtesting.SeedInfo.seed([6E71CCF15FED0624:C8ADF50491D951DA]:0)
[junit4] > at org.apache.solr.util.TimeOut.waitFor(TimeOut.java:66)
[junit4] > at org.apache.solr.cloud.autoscaling.sim.SimScenario$LoadAutoscaling.execute(SimScenario.java:464)
[junit4] > at org.apache.solr.cloud.autoscaling.sim.SimScenario.run(SimScenario.java:1106)
[junit4] > at org.apache.solr.cloud.autoscaling.sim.TestSimScenario.testSuggestions(TestSimScenario.java:94)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J3/temp/solr.cloud.autoscaling.sim.TestSimScenario_6E71CCF15FED0624-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene84): {}, docValues:{}, maxPointsInLeafNode=869, maxMBSortInHeap=7.587297557388453, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@77ae92a4), locale=zh, timezone=America/North_Dakota/Beulah
[junit4] 2> NOTE: Linux 5.3.0-46-generic amd64/Oracle Corporation 1.8.0_201 (64-bit)/cpus=16,threads=1,free=244106576,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestDeleteCollectionOnDownNodes, PreAnalyzedFieldManagedSchemaCloudTest, TestWaitForStateWithJettyShutdowns, OverriddenZkACLAndCredentialsProvidersTest, CoreMergeIndexesAdminHandlerTest, BitVectorTest, AddBlockUpdateTest, TestBadConfig, StatsComponentTest, TestDistributedMissingSort, TestInPlaceUpdatesStandalone, TestDocTermOrds, SegmentsInfoRequestHandlerTest, HdfsRecoverLeaseTest, TestSearchPerf, ShardRoutingTest, TestImpersonationWithHadoopAuth, SimpleMLTQParserTest, ScriptEngineTest, SampleTest, TestSolrIndexConfig, WordBreakSolrSpellCheckerTest, TestConfigReload, FullSolrCloudDistribCmdsTest, CollectionsAPIDistributedZkTest, TestSubQueryTransformerCrossCore, ExecutePlanActionTest, AnalyticsQueryTest, DirectoryFactoryTest, ConfigSetsAPITest, LukeRequestHandlerTest, RootFieldTest, TestNamedUpdateProcessors, BooleanFieldTest, TestHashPartitioner, TestRemoteStreaming, ZkStateWriterTest, OverseerStatusTest, TestSweetSpotSimilarityFactory, TestMissingGroups, BadComponentTest, TestNumericRangeQuery32, UniqFieldsUpdateProcessorFactoryTest, TestMaxTokenLenTokenizer, HdfsUnloadDistributedZkTest, TestAddFieldRealTimeGet, DistribJoinFromCollectionTest, TestLMDirichletSimilarityFactory, TestApiFramework, SplitShardTest, TestPhraseSuggestions, CdcrBootstrapTest, TestScoreJoinQPNoScore, TestTrie, TestSystemIdResolver, DistributedSuggestComponentTest, MoreLikeThisHandlerTest, AdminHandlersProxyTest, TestRandomDVFaceting, DateMathParserTest, ClusterStateTest, PrimUtilsTest, IndexBasedSpellCheckerTest, TestLRUStatsCache, TestSimScenario]
[junit4] Completed [444/907 (1!)] on J3 in 3.01s, 4 tests, 1 error <<< FAILURES!
[...truncated 54196 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/2895/consoleText
[repro] Revision: 489278b87ab361a26860e4f7649106444255eccf
[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseConcMarkSweepGC"
[repro] Repro line: ant test -Dtestcase=TestSimScenario -Dtests.method=testSuggestions -Dtests.seed=6E71CCF15FED0624 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=zh -Dtests.timezone=America/North_Dakota/Beulah -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[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] TestSimScenario
[repro] ant compile-test
[...truncated 3457 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.TestSimScenario" -Dtests.showOutput=onerror "-Dargs=-XX:-UseCompressedOops -XX:+UseConcMarkSweepGC" -Dtests.seed=6E71CCF15FED0624 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=zh -Dtests.timezone=America/North_Dakota/Beulah -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[...truncated 91 lines...]
[repro] Failures w/original seeds:
[repro] 0/5 failed: org.apache.solr.cloud.autoscaling.sim.TestSimScenario
[repro] Exiting with code 0
[...truncated 43 lines...]