Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/4580/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseParallelGC

1 tests failed.
FAILED:  
org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest.testSplitIntegration

Error Message:


Stack Trace:
java.util.concurrent.TimeoutException
        at 
__randomizedtesting.SeedInfo.seed([9099CE97C674347B:A91777D7E98BFD85]:0)
        at 
org.apache.solr.cloud.CloudTestUtils.waitForState(CloudTestUtils.java:109)
        at 
org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest.testSplitIntegration(IndexSizeTriggerTest.java:299)
        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:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
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 13342 lines...]
   [junit4] Suite: org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest
   [junit4]   2> Creating dataDir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.IndexSizeTriggerTest_9099CE97C674347B-001/init-core-data-001
   [junit4]   2> 1519064 INFO  
(SUITE-IndexSizeTriggerTest-seed#[9099CE97C674347B]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1519071 INFO  
(SUITE-IndexSizeTriggerTest-seed#[9099CE97C674347B]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) 
w/ MAC_OS_X supressed clientAuth
   [junit4]   2> 1519071 INFO  
(SUITE-IndexSizeTriggerTest-seed#[9099CE97C674347B]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1519072 INFO  
(SUITE-IndexSizeTriggerTest-seed#[9099CE97C674347B]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.IndexSizeTriggerTest_9099CE97C674347B-001/tempDir-001
   [junit4]   2> 1519072 INFO  
(SUITE-IndexSizeTriggerTest-seed#[9099CE97C674347B]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1519073 INFO  (Thread-2465) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1519073 INFO  (Thread-2465) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1519076 ERROR (Thread-2465) [    ] o.a.z.s.ZooKeeperServer 
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action 
on ERROR or SHUTDOWN server state changes
   [junit4]   2> 1519177 INFO  
(SUITE-IndexSizeTriggerTest-seed#[9099CE97C674347B]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:52589
   [junit4]   2> 1519196 INFO  (zkConnectionManagerCallback-3842-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1519204 INFO  (jetty-launcher-3839-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-21T16:27:37-05:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 1519204 INFO  (jetty-launcher-3839-thread-2) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-21T16:27:37-05:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 1519206 INFO  (jetty-launcher-3839-thread-2) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1519206 INFO  (jetty-launcher-3839-thread-2) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1519206 INFO  (jetty-launcher-3839-thread-2) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 1519206 INFO  (jetty-launcher-3839-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@a3772b6{/solr,null,AVAILABLE}
   [junit4]   2> 1519206 INFO  (jetty-launcher-3839-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1519206 INFO  (jetty-launcher-3839-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1519206 INFO  (jetty-launcher-3839-thread-1) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 1519207 INFO  (jetty-launcher-3839-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1648924a{/solr,null,AVAILABLE}
   [junit4]   2> 1519212 INFO  (jetty-launcher-3839-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@54b7e8fe{HTTP/1.1,[http/1.1]}{127.0.0.1:52592}
   [junit4]   2> 1519213 INFO  (jetty-launcher-3839-thread-1) [    ] 
o.e.j.s.Server Started @1519323ms
   [junit4]   2> 1519213 INFO  (jetty-launcher-3839-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=52592}
   [junit4]   2> 1519213 INFO  (jetty-launcher-3839-thread-2) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@5053865c{HTTP/1.1,[http/1.1]}{127.0.0.1:52591}
   [junit4]   2> 1519213 INFO  (jetty-launcher-3839-thread-2) [    ] 
o.e.j.s.Server Started @1519323ms
   [junit4]   2> 1519213 INFO  (jetty-launcher-3839-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=52591}
   [junit4]   2> 1519213 ERROR (jetty-launcher-3839-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1519213 INFO  (jetty-launcher-3839-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1519213 INFO  (jetty-launcher-3839-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1519213 ERROR (jetty-launcher-3839-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1519213 INFO  (jetty-launcher-3839-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1519213 INFO  (jetty-launcher-3839-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1519213 INFO  (jetty-launcher-3839-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1519213 INFO  (jetty-launcher-3839-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1519213 INFO  (jetty-launcher-3839-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-04-23T05:07:08.656Z
   [junit4]   2> 1519213 INFO  (jetty-launcher-3839-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1519213 INFO  (jetty-launcher-3839-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1519213 INFO  (jetty-launcher-3839-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-04-23T05:07:08.656Z
   [junit4]   2> 1519221 INFO  (zkConnectionManagerCallback-3844-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1519221 INFO  (zkConnectionManagerCallback-3846-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1519221 INFO  (jetty-launcher-3839-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1519222 INFO  (jetty-launcher-3839-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1519250 INFO  (jetty-launcher-3839-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:52589/solr
   [junit4]   2> 1519250 INFO  (jetty-launcher-3839-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:52589/solr
   [junit4]   2> 1519256 INFO  (zkConnectionManagerCallback-3851-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1519256 INFO  (zkConnectionManagerCallback-3854-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1519261 INFO  (zkConnectionManagerCallback-3856-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1519261 INFO  (zkConnectionManagerCallback-3858-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1519447 INFO  (jetty-launcher-3839-thread-2) 
[n:127.0.0.1:52591_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1519447 INFO  (jetty-launcher-3839-thread-1) 
[n:127.0.0.1:52592_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1519448 INFO  (jetty-launcher-3839-thread-2) 
[n:127.0.0.1:52591_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:52591_solr
   [junit4]   2> 1519449 INFO  (jetty-launcher-3839-thread-1) 
[n:127.0.0.1:52592_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:52592_solr
   [junit4]   2> 1519451 INFO  (zkCallback-3855-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1519452 INFO  (zkCallback-3857-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1519453 INFO  (jetty-launcher-3839-thread-2) 
[n:127.0.0.1:52591_solr    ] o.a.s.c.Overseer Overseer 
(id=72062494236147718-127.0.0.1:52591_solr-n_0000000000) starting
   [junit4]   2> 1519465 INFO  (zkConnectionManagerCallback-3867-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1519467 INFO  (jetty-launcher-3839-thread-2) 
[n:127.0.0.1:52591_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1519469 INFO  (jetty-launcher-3839-thread-2) 
[n:127.0.0.1:52591_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:52589/solr ready
   [junit4]   2> 1519471 DEBUG 
(OverseerAutoScalingTriggerThread-72062494236147718-127.0.0.1:52591_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and 
.scheduled_maintenance triggers
   [junit4]   2> 1519472 DEBUG 
(OverseerAutoScalingTriggerThread-72062494236147718-127.0.0.1:52591_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode 
version 1
   [junit4]   2> 1519473 DEBUG 
(OverseerAutoScalingTriggerThread-72062494236147718-127.0.0.1:52591_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, 
lastZnodeVersion -1
   [junit4]   2> 1519473 DEBUG 
(OverseerAutoScalingTriggerThread-72062494236147718-127.0.0.1:52591_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto 
znodeVersion 1
   [junit4]   2> 1519474 INFO  (jetty-launcher-3839-thread-2) 
[n:127.0.0.1:52591_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1519474 INFO  (jetty-launcher-3839-thread-2) 
[n:127.0.0.1:52591_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:52591_solr
   [junit4]   2> 1519478 INFO  (zkCallback-3866-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1519478 INFO  (zkCallback-3855-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1519478 INFO  (zkCallback-3857-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1519484 DEBUG 
(OverseerAutoScalingTriggerThread-72062494236147718-127.0.0.1:52591_solr-n_0000000000)
 [    ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial 
livenodes: [127.0.0.1:52592_solr, 127.0.0.1:52591_solr]
   [junit4]   2> 1519485 DEBUG 
(OverseerAutoScalingTriggerThread-72062494236147718-127.0.0.1:52591_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1519486 DEBUG 
(OverseerAutoScalingTriggerThread-72062494236147718-127.0.0.1:52591_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, 
lastZnodeVersion 1
   [junit4]   2> 1519487 DEBUG (ScheduledTrigger-5126-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1519730 INFO  (jetty-launcher-3839-thread-2) 
[n:127.0.0.1:52591_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_52591.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5ebb91dd
   [junit4]   2> 1519738 INFO  (jetty-launcher-3839-thread-2) 
[n:127.0.0.1:52591_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_52591.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5ebb91dd
   [junit4]   2> 1519738 INFO  (jetty-launcher-3839-thread-2) 
[n:127.0.0.1:52591_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_52591.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5ebb91dd
   [junit4]   2> 1519739 INFO  (jetty-launcher-3839-thread-2) 
[n:127.0.0.1:52591_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.IndexSizeTriggerTest_9099CE97C674347B-001/tempDir-001/node2/.
   [junit4]   2> 1519821 INFO  (jetty-launcher-3839-thread-1) 
[n:127.0.0.1:52592_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_52592.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5ebb91dd
   [junit4]   2> 1519825 INFO  (jetty-launcher-3839-thread-1) 
[n:127.0.0.1:52592_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_52592.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5ebb91dd
   [junit4]   2> 1519826 INFO  (jetty-launcher-3839-thread-1) 
[n:127.0.0.1:52592_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_52592.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@5ebb91dd
   [junit4]   2> 1519827 INFO  (jetty-launcher-3839-thread-1) 
[n:127.0.0.1:52592_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.IndexSizeTriggerTest_9099CE97C674347B-001/tempDir-001/node1/.
   [junit4]   2> 1519831 INFO  (zkConnectionManagerCallback-3872-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1519833 INFO  (jetty-launcher-3839-thread-1) 
[n:127.0.0.1:52592_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 1519836 INFO  (jetty-launcher-3839-thread-1) 
[n:127.0.0.1:52592_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:52589/solr ready
   [junit4]   2> 1519871 INFO  (zkConnectionManagerCallback-3874-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1519874 INFO  (zkConnectionManagerCallback-3879-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1519880 INFO  
(SUITE-IndexSizeTriggerTest-seed#[9099CE97C674347B]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 1519882 INFO  
(SUITE-IndexSizeTriggerTest-seed#[9099CE97C674347B]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:52589/solr ready
   [junit4]   2> 1520490 DEBUG (ScheduledTrigger-5126-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1520899 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and 
.scheduled_maintenance triggers
   [junit4]   2> 1520900 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode 
version 0
   [junit4]   2> 1520900 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion -1
   [junit4]   2> 1520900 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 0
   [junit4]   2> 1520905 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:10000_solr]
   [junit4]   2> 1520906 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1520906 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion 0
   [junit4]   2> 1520907 DEBUG (ScheduledTrigger-5135-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1520936 DEBUG (ScheduledTrigger-5135-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1520963 DEBUG (ScheduledTrigger-5135-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1520986 DEBUG (ScheduledTrigger-5135-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521007 DEBUG (ScheduledTrigger-5135-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521031 DEBUG (ScheduledTrigger-5135-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521060 DEBUG (ScheduledTrigger-5135-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521088 DEBUG (ScheduledTrigger-5135-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521109 DEBUG (ScheduledTrigger-5135-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521136 DEBUG (ScheduledTrigger-5135-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521144 INFO  
(TEST-IndexSizeTriggerTest.testTrigger-seed#[9099CE97C674347B]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testTrigger
   [junit4]   2> 1521159 DEBUG (ScheduledTrigger-5135-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521187 DEBUG (ScheduledTrigger-5135-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521212 DEBUG (ScheduledTrigger-5135-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521237 DEBUG (ScheduledTrigger-5135-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521240 DEBUG (simCloudManagerPool-5134-thread-6) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for 
testTrigger_collection / shard2: {"core_node3":{
   [junit4]   2>     "core":"testTrigger_collection_shard2_replica_n3",
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>     "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>     "INDEX.sizeInBytes":1,
   [junit4]   2>     "node_name":"127.0.0.1:10000_solr",
   [junit4]   2>     "state":"active",
   [junit4]   2>     "type":"NRT",
   [junit4]   2>     "SEARCHER.searcher.numDocs":0,
   [junit4]   2>     "shard":"shard2",
   [junit4]   2>     "collection":"testTrigger_collection"}}
   [junit4]   2> 1521245 DEBUG (simCloudManagerPool-5134-thread-7) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for 
testTrigger_collection / shard1: {"core_node1":{
   [junit4]   2>     "core":"testTrigger_collection_shard1_replica_n1",
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>     "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>     "INDEX.sizeInBytes":1,
   [junit4]   2>     "node_name":"127.0.0.1:10000_solr",
   [junit4]   2>     "state":"active",
   [junit4]   2>     "type":"NRT",
   [junit4]   2>     "SEARCHER.searcher.numDocs":0,
   [junit4]   2>     "shard":"shard1",
   [junit4]   2>     "collection":"testTrigger_collection"}}
   [junit4]   2> 1521262 DEBUG (ScheduledTrigger-5135-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521290 DEBUG (ScheduledTrigger-5135-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521312 DEBUG (ScheduledTrigger-5135-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521338 DEBUG (ScheduledTrigger-5135-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521361 DEBUG (ScheduledTrigger-5135-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521392 DEBUG (ScheduledTrigger-5135-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521427 DEBUG (ScheduledTrigger-5135-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521449 DEBUG (ScheduledTrigger-5135-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521471 DEBUG (ScheduledTrigger-5135-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521492 DEBUG (ScheduledTrigger-5126-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521492 DEBUG (ScheduledTrigger-5135-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521518 DEBUG (ScheduledTrigger-5135-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521539 DEBUG (ScheduledTrigger-5135-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1521556 INFO  
(TEST-IndexSizeTriggerTest.testTrigger-seed#[9099CE97C674347B]) [    ] 
o.a.s.c.a.IndexSizeTriggerTest #######################################
   [junit4]   2> ############ CLUSTER STATE ############
   [junit4]   2> #######################################
   [junit4]   2> ## Live nodes:         2
   [junit4]   2> ## Empty nodes:        0
   [junit4]   2> ## Dead nodes:         0
   [junit4]   2> ## Collections:        [testTrigger_collection]
   [junit4]   2> DocCollection(testTrigger_collection//clusterstate.json/28)={
   [junit4]   2>   "replicationFactor":"2",
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"2",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"2",
   [junit4]   2>   "tlogReplicas":"0",
   [junit4]   2>   "autoCreated":"true",
   [junit4]   2>   "shards":{
   [junit4]   2>     "shard2":{
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node3":{
   [junit4]   2>           "core":"testTrigger_collection_shard2_replica_n3",
   [junit4]   2>           "leader":"true",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":11,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":1,
   [junit4]   2>           "node_name":"127.0.0.1:10000_solr",
   [junit4]   2>           "state":"active",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.numDocs":11},
   [junit4]   2>         "core_node4":{
   [junit4]   2>           "core":"testTrigger_collection_shard2_replica_n4",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":11,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":1,
   [junit4]   2>           "node_name":"127.0.0.1:10001_solr",
   [junit4]   2>           "state":"active",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.numDocs":11}},
   [junit4]   2>       "range":"0-7fffffff",
   [junit4]   2>       "state":"active"},
   [junit4]   2>     "shard1":{
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node1":{
   [junit4]   2>           "core":"testTrigger_collection_shard1_replica_n1",
   [junit4]   2>           "leader":"true",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":14,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":1,
   [junit4]   2>           "node_name":"127.0.0.1:10000_solr",
   [junit4]   2>           "state":"active",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.numDocs":14},
   [junit4]   2>         "core_node2":{
   [junit4]   2>           "core":"testTrigger_collection_shard1_replica_n2",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":14,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":1,
   [junit4]   2>           "node_name":"127.0.0.1:10001_solr",
   [junit4]   2>           "state":"active",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.numDocs":14}},
   [junit4]   2>       "range":"80000000-ffffffff",
   [junit4]   2>       "state":"active"}}}
   [junit4]   2> ## Max replicas per node:      2
   [junit4]   2> ## Min replicas per node:      2
   [junit4]   2> ## Total replicas:             4
   [junit4]   2> ## * testTrigger_collection            4
   [junit4]   2> ##             - active           4
   [junit4]   2> ######### Solr op counts ##########
   [junit4]   2> ##             - CREATE             1
   [junit4]   2> ##             - update            26
   [junit4]   2> ######### Autoscaling event counts ###########
   [junit4]   2> 
   [junit4]   2> 1521557 DEBUG 
(TEST-IndexSizeTriggerTest.testTrigger-seed#[9099CE97C674347B]) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
1
   [junit4]   2> 1521557 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
   [junit4]   2> 1521558 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
   [junit4]   2> 1521558 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1521558 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 1521659 INFO  
(TEST-IndexSizeTriggerTest.testTrigger-seed#[9099CE97C674347B]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testTrigger
   [junit4]   2> 1521795 INFO  
(TEST-IndexSizeTriggerTest.testMixedBounds-seed#[9099CE97C674347B]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testMixedBounds
   [junit4]   2> 1521796 WARN  
(TEST-IndexSizeTriggerTest.testMixedBounds-seed#[9099CE97C674347B]) [    ] 
o.a.s.c.a.IndexSizeTriggerTest Requires SOLR-12208
   [junit4]   2> 1521796 INFO  
(TEST-IndexSizeTriggerTest.testMixedBounds-seed#[9099CE97C674347B]) [    ] 
o.a.s.c.a.IndexSizeTriggerTest #######################################
   [junit4]   2> ############ CLUSTER STATE ############
   [junit4]   2> #######################################
   [junit4]   2> ## Live nodes:         2
   [junit4]   2> ## Empty nodes:        2
   [junit4]   2> ## Dead nodes:         0
   [junit4]   2> ## Collections:        []
   [junit4]   2> ## Max replicas per node:      0
   [junit4]   2> ## Min replicas per node:      0
   [junit4]   2> ## Total replicas:             0
   [junit4]   2> ######### Solr op counts ##########
   [junit4]   2> ######### Autoscaling event counts ###########
   [junit4]   2> 
   [junit4]   2> 1521796 DEBUG 
(TEST-IndexSizeTriggerTest.testMixedBounds-seed#[9099CE97C674347B]) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
2
   [junit4]   2> 1521796 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
   [junit4]   2> 1521796 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
   [junit4]   2> 1521796 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1521796 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
   [junit4]   2> 1521907 INFO  
(TEST-IndexSizeTriggerTest.testMixedBounds-seed#[9099CE97C674347B]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testMixedBounds
   [junit4]   2> 1521999 INFO  
(TEST-IndexSizeTriggerTest.testMergeIntegration-seed#[9099CE97C674347B]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testMergeIntegration
   [junit4]   2> 1522051 DEBUG (simCloudManagerPool-5134-thread-39) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for 
testMergeIntegration_collection / shard2: {"core_node3":{
   [junit4]   2>     "core":"testMergeIntegration_collection_shard2_replica_n3",
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>     "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>     "INDEX.sizeInBytes":1,
   [junit4]   2>     "node_name":"127.0.0.1:10001_solr",
   [junit4]   2>     "state":"active",
   [junit4]   2>     "type":"NRT",
   [junit4]   2>     "SEARCHER.searcher.numDocs":0,
   [junit4]   2>     "shard":"shard2",
   [junit4]   2>     "collection":"testMergeIntegration_collection"}}
   [junit4]   2> 1522052 DEBUG (simCloudManagerPool-5134-thread-40) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for 
testMergeIntegration_collection / shard1: {"core_node1":{
   [junit4]   2>     "core":"testMergeIntegration_collection_shard1_replica_n1",
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>     "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>     "INDEX.sizeInBytes":1,
   [junit4]   2>     "node_name":"127.0.0.1:10001_solr",
   [junit4]   2>     "state":"active",
   [junit4]   2>     "type":"NRT",
   [junit4]   2>     "SEARCHER.searcher.numDocs":0,
   [junit4]   2>     "shard":"shard1",
   [junit4]   2>     "collection":"testMergeIntegration_collection"}}
   [junit4]   2> 1522145 DEBUG (simCloudManagerPool-5134-thread-52) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1522145 DEBUG (simCloudManagerPool-5134-thread-52) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
3
   [junit4]   2> 1522148 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 3
   [junit4]   2> 1522149 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
   [junit4]   2> 1522149 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1522149 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion 3
   [junit4]   2> 1522172 DEBUG (simCloudManagerPool-5134-thread-53) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1522172 DEBUG (simCloudManagerPool-5134-thread-53) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
4
   [junit4]   2> 1522173 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 4
   [junit4]   2> 1522173 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
   [junit4]   2> 1522173 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1522173 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 4, lastZnodeVersion 4
   [junit4]   2> 1522183 DEBUG (simCloudManagerPool-5134-thread-54) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1522183 DEBUG (simCloudManagerPool-5134-thread-54) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
5
   [junit4]   2> 1522183 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 5
   [junit4]   2> 1522184 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
   [junit4]   2> 1522184 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1522184 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 5, lastZnodeVersion 5
   [junit4]   2> 1522468 DEBUG (ScheduledTrigger-5135-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown inactive - processing event: {
   [junit4]   2>   "id":"441a54763f30T3savtrnsa38jr34xhho7g95gv",
   [junit4]   2>   "source":"index_size_trigger",
   [junit4]   2>   "eventTime":74879876874032,
   [junit4]   2>   "eventType":"INDEXSIZE",
   [junit4]   2>   "properties":{
   [junit4]   2>     "aboveSize":{},
   [junit4]   2>     "belowSize":{"testMergeIntegration_collection":[
   [junit4]   2>         "{\"core_node1\":{\n    
\"core\":\"testMergeIntegration_collection_shard1_replica_n1\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":7,\n    
\"SEARCHER.searcher.deletedDocs\":5,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":2,\n    \"violationType\":\"belowDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":2,\n    \"__bytes__\":1,\n 
   \"shard\":\"shard1\",\n    
\"collection\":\"testMergeIntegration_collection\"}}",
   [junit4]   2>         "{\"core_node3\":{\n    
\"core\":\"testMergeIntegration_collection_shard2_replica_n3\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":3,\n    
\"SEARCHER.searcher.deletedDocs\":0,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":3,\n    \"violationType\":\"belowDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":3,\n    \"__bytes__\":1,\n 
   \"shard\":\"shard2\",\n    
\"collection\":\"testMergeIntegration_collection\"}}"]},
   [junit4]   2>     "requestedOps":["Op{action=MERGESHARDS, 
hints={COLL_SHARD=[{\n  \"first\":\"testMergeIntegration_collection\",\n  
\"second\":\"shard2\"}, {\n  \"first\":\"testMergeIntegration_collection\",\n  
\"second\":\"shard1\"}]}}"]}}
   [junit4]   2> 1522477 DEBUG (ScheduledTrigger-5135-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers Pausing all triggers: [index_size_trigger]
   [junit4]   2> 1522484 INFO  (ScheduledTrigger-5135-thread-4) [    ] 
o.a.s.c.a.IndexSizeTriggerTest =======> CapturedEvent{timestamp=74896586961232, 
stage=STARTED, actionName='null', event={
   [junit4]   2>   "id":"441a54763f30T3savtrnsa38jr34xhho7g95gv",
   [junit4]   2>   "source":"index_size_trigger",
   [junit4]   2>   "eventTime":74879876874032,
   [junit4]   2>   "eventType":"INDEXSIZE",
   [junit4]   2>   "properties":{
   [junit4]   2>     "aboveSize":{},
   [junit4]   2>     "belowSize":{"testMergeIntegration_collection":[
   [junit4]   2>         "{\"core_node1\":{\n    
\"core\":\"testMergeIntegration_collection_shard1_replica_n1\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":7,\n    
\"SEARCHER.searcher.deletedDocs\":5,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":2,\n    \"violationType\":\"belowDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":2,\n    \"__bytes__\":1,\n 
   \"shard\":\"shard1\",\n    
\"collection\":\"testMergeIntegration_collection\"}}",
   [junit4]   2>         "{\"core_node3\":{\n    
\"core\":\"testMergeIntegration_collection_shard2_replica_n3\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":3,\n    
\"SEARCHER.searcher.deletedDocs\":0,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":3,\n    \"violationType\":\"belowDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":3,\n    \"__bytes__\":1,\n 
   \"shard\":\"shard2\",\n    
\"collection\":\"testMergeIntegration_collection\"}}"]},
   [junit4]   2>     "_enqueue_time_":74896255278682,
   [junit4]   2>     "requestedOps":["Op{action=MERGESHARDS, 
hints={COLL_SHARD=[{\n  \"first\":\"testMergeIntegration_collection\",\n  
\"second\":\"shard2\"}, {\n  \"first\":\"testMergeIntegration_collection\",\n  
\"second\":\"shard1\"}]}}"]}}, context={}, config={
   [junit4]   2>   "trigger":"index_size_trigger",
   [junit4]   2>   "stage":[
   [junit4]   2>     "STARTED",
   [junit4]   2>     "ABORTED",
   [junit4]   2>     "SUCCEEDED",
   [junit4]   2>     "FAILED"],
   [junit4]   2>   "afterAction":[
   [junit4]   2>     "compute_plan",
   [junit4]   2>     "execute_plan"],
   [junit4]   2>   
"class":"org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest$CapturingTriggerListener",
   [junit4]   2>   "beforeAction":[
   [junit4]   2>     "compute_plan",
   [junit4]   2>     "execute_plan"]}, message='null'}
   [junit4]   2> 1522494 DEBUG (ScheduledTrigger-5126-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2
   [junit4]   2> 1522496 DEBUG (AutoscalingActionExecutor-5136-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -- processing actions for {
   [junit4]   2>   "id":"441a54763f30T3savtrnsa38jr34xhho7g95gv",
   [junit4]   2>   "source":"index_size_trigger",
   [junit4]   2>   "eventTime":74879876874032,
   [junit4]   2>   "eventType":"INDEXSIZE",
   [junit4]   2>   "properties":{
   [junit4]   2>     "aboveSize":{},
   [junit4]   2>     "belowSize":{"testMergeIntegration_collection":[
   [junit4]   2>         "{\"core_node1\":{\n    
\"core\":\"testMergeIntegration_collection_shard1_replica_n1\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":7,\n    
\"SEARCHER.searcher.deletedDocs\":5,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":2,\n    \"violationType\":\"belowDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":2,\n    \"__bytes__\":1,\n 
   \"shard\":\"shard1\",\n    
\"collection\":\"testMergeIntegration_collection\"}}",
   [junit4]   2>         "{\"core_node3\":{\n    
\"core\":\"testMergeIntegration_collection_shard2_replica_n3\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":3,\n    
\"SEARCHER.searcher.deletedDocs\":0,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":3,\n    \"violationType\":\"belowDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":3,\n    \"__bytes__\":1,\n 
   \"shard\":\"shard2\",\n    
\"collection\":\"testMergeIntegration_collection\"}}"]},
   [junit4]   2>     "_enqueue_time_":74896255278682,
   [junit4]   2>     "requestedOps":["Op{action=MERGESHARDS, 
hints={COLL_SHARD=[{\n  \"first\":\"testMergeIntegration_collection\",\n  
\"second\":\"shard2\"}, {\n  \"first\":\"testMergeIntegration_collection\",\n  
\"second\":\"shard1\"}]}}"]}}
   [junit4]   2> 1522498 INFO  (AutoscalingActionExecutor-5136-thread-1) [    ] 
o.a.s.c.a.IndexSizeTriggerTest =======> CapturedEvent{timestamp=74897261262182, 
stage=BEFORE_ACTION, actionName='compute_plan', event={
   [junit4]   2>   "id":"441a54763f30T3savtrnsa38jr34xhho7g95gv",
   [junit4]   2>   "source":"index_size_trigger",
   [junit4]   2>   "eventTime":74879876874032,
   [junit4]   2>   "eventType":"INDEXSIZE",
   [junit4]   2>   "properties":{
   [junit4]   2>     "aboveSize":{},
   [junit4]   2>     "belowSize":{"testMergeIntegration_collection":[
   [junit4]   2>         "{\"core_node1\":{\n    
\"core\":\"testMergeIntegration_collection_shard1_replica_n1\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":7,\n    
\"SEARCHER.searcher.deletedDocs\":5,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":2,\n    \"violationType\":\"belowDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":2,\n    \"__bytes__\":1,\n 
   \"shard\":\"shard1\",\n    
\"collection\":\"testMergeIntegration_collection\"}}",
   [junit4]   2>         "{\"core_node3\":{\n    
\"core\":\"testMergeIntegration_collection_shard2_replica_n3\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":3,\n    
\"SEARCHER.searcher.deletedDocs\":0,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":3,\n    \"violationType\":\"belowDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":3,\n    \"__bytes__\":1,\n 
   \"shard\":\"shard2\",\n    
\"collection\":\"testMergeIntegration_collection\"}}"]},
   [junit4]   2>     "_enqueue_time_":74896255278682,
   [junit4]   2>     "requestedOps":["Op{action=MERGESHARDS, 
hints={COLL_SHARD=[{\n  \"first\":\"testMergeIntegration_collection\",\n  
\"second\":\"shard2\"}, {\n  \"first\":\"testMergeIntegration_collection\",\n  
\"second\":\"shard1\"}]}}"]}}, 
context={properties.BEFORE_ACTION=[compute_plan], source=index_size_trigger}, 
config={
   [junit4]   2>   "trigger":"index_size_trigger",
   [junit4]   2>   "stage":[
   [junit4]   2>     "STARTED",
   [junit4]   2>     "ABORTED",
   [junit4]   2>     "SUCCEEDED",
   [junit4]   2>     "FAILED"],
   [junit4]   2>   "afterAction":[
   [junit4]   2>     "compute_plan",
   [junit4]   2>     "execute_plan"],
   [junit4]   2>   
"class":"org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest$CapturingTriggerListener",
   [junit4]   2>   "beforeAction":[
   [junit4]   2>     "compute_plan",
   [junit4]   2>     "execute_plan"]}, message='null'}
   [junit4]   2> 1522498 DEBUG (AutoscalingActionExecutor-5136-thread-1) [    ] 
o.a.s.c.a.ComputePlanAction -- processing event: {
   [junit4]   2>   "id":"441a54763f30T3savtrnsa38jr34xhho7g95gv",
   [junit4]   2>   "source":"index_size_trigger",
   [junit4]   2>   "eventTime":74879876874032,
   [junit4]   2>   "eventType":"INDEXSIZE",
   [junit4]   2>   "properties":{
   [junit4]   2>     "aboveSize":{},
   [junit4]   2>     "belowSize":{"testMergeIntegration_collection":[
   [junit4]   2>         "{\"core_node1\":{\n    
\"core\":\"testMergeIntegration_collection_shard1_replica_n1\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":7,\n    
\"SEARCHER.searcher.deletedDocs\":5,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":2,\n    \"violationType\":\"belowDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":2,\n    \"__bytes__\":1,\n 
   \"shard\":\"shard1\",\n    
\"collection\":\"testMergeIntegration_collection\"}}",
   [junit4]   2>         "{\"core_node3\":{\n    
\"core\":\"testMergeIntegration_collection_shard2_replica_n3\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":3,\n    
\"SEARCHER.searcher.deletedDocs\":0,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":3,\n    \"violationType\":\"belowDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":3,\n    \"__bytes__\":1,\n 
   \"shard\":\"shard2\",\n    
\"collection\":\"testMergeIntegration_collection\"}}"]},
   [junit4]   2>     "_enqueue_time_":74896255278682,
   [junit4]   2>     "requestedOps":["Op{action=MERGESHARDS, 
hints={COLL_SHARD=[{\n  \"first\":\"testMergeIntegration_collection\",\n  
\"second\":\"shard2\"}, {\n  \"first\":\"testMergeIntegration_collection\",\n  
\"second\":\"shard1\"}]}}"]}} with context properties: 
{BEFORE_ACTION=[compute_plan]}
   [junit4]   2> 1522503 INFO  (AutoscalingActionExecutor-5136-thread-1) [    ] 
o.a.s.c.a.ComputePlanAction Computed plan empty, remained 0 requested ops to 
try.
   [junit4]   2> 1522503 INFO  (AutoscalingActionExecutor-5136-thread-1) [    ] 
o.a.s.c.s.c.a.PolicyHelper returnSession, curr-time 74897546 
sessionWrapper.createTime 74897365436232, this.sessionWrapper.createTime 
74897365436232 
   [junit4]   2> 1522503 INFO  (AutoscalingActionExecutor-5136-thread-1) [    ] 
o.a.s.c.a.IndexSizeTriggerTest =======> CapturedEvent{timestamp=74897551743482, 
stage=AFTER_ACTION, actionName='compute_plan', event={
   [junit4]   2>   "id":"441a54763f30T3savtrnsa38jr34xhho7g95gv",
   [junit4]   2>   "source":"index_size_trigger",
   [junit4]   2>   "eventTime":74879876874032,
   [junit4]   2>   "eventType":"INDEXSIZE",
   [junit4]   2>   "properties":{
   [junit4]   2>     "__start__":1,
   [junit4]   2>     "aboveSize":{},
   [junit4]   2>     "belowSize":{"testMergeIntegration_collection":[
   [junit4]   2>         "{\"core_node1\":{\n    
\"core\":\"testMergeIntegration_collection_shard1_replica_n1\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":7,\n    
\"SEARCHER.searcher.deletedDocs\":5,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":2,\n    \"violationType\":\"belowDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":2,\n    \"__bytes__\":1,\n 
   \"shard\":\"shard1\",\n    
\"collection\":\"testMergeIntegration_collection\"}}",
   [junit4]   2>         "{\"core_node3\":{\n    
\"core\":\"testMergeIntegration_collection_shard2_replica_n3\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":3,\n    
\"SEARCHER.searcher.deletedDocs\":0,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":3,\n    \"violationType\":\"belowDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":3,\n    \"__bytes__\":1,\n 
   \"shard\":\"shard2\",\n    
\"collection\":\"testMergeIntegration_collection\"}}"]},
   [junit4]   2>     "_enqueue_time_":74896255278682,
   [junit4]   2>     "requestedOps":["Op{action=MERGESHARDS, 
hints={COLL_SHARD=[{\n  \"first\":\"testMergeIntegration_collection\",\n  
\"second\":\"shard2\"}, {\n  \"first\":\"testMergeIntegration_collection\",\n  
\"second\":\"shard1\"}]}}"]}}, 
context={properties.unsupportedOps=[Op{action=MERGESHARDS, hints={COLL_SHARD=[{
   [junit4]   2>   "first":"testMergeIntegration_collection",
   [junit4]   2>   "second":"shard2"}, {
   [junit4]   2>   "first":"testMergeIntegration_collection",
   [junit4]   2>   "second":"shard1"}]}}], 
properties.BEFORE_ACTION=[compute_plan], source=index_size_trigger, 
properties.AFTER_ACTION=[compute_plan]}, config={
   [junit4]   2>   "trigger":"index_size_trigger",
   [junit4]   2>   "stage":[
   [junit4]   2>     "STARTED",
   [junit4]   2>     "ABORTED",
   [junit4]   2>     "SUCCEEDED",
   [junit4]   2>     "FAILED"],
   [junit4]   2>   "afterAction":[
   [junit4]   2>     "compute_plan",
   [junit4]   2>     "execute_plan"],
   [junit4]   2>   
"class":"org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest$CapturingTriggerListener",
   [junit4]   2>   "beforeAction":[
   [junit4]   2>     "compute_plan",
   [junit4]   2>     "execute_plan"]}, message='null'}
   [junit4]   2> 1522504 INFO  (AutoscalingActionExecutor-5136-thread-1) [    ] 
o.a.s.c.a.IndexSizeTriggerTest =======> CapturedEvent{timestamp=74897570998482, 
stage=BEFORE_ACTION, actionName='execute_plan', event={
   [junit4]   2>   "id":"441a54763f30T3savtrnsa38jr34xhho7g95gv",
   [junit4]   2>   "source":"index_size_trigger",
   [junit4]   2>   "eventTime":74879876874032,
   [junit4]   2>   "eventType":"INDEXSIZE",
   [junit4]   2>   "properties":{
   [junit4]   2>     "__start__":1,
   [junit4]   2>     "aboveSize":{},
   [junit4]   2>     "belowSize":{"testMergeIntegration_collection":[
   [junit4]   2>         "{\"core_node1\":{\n    
\"core\":\"testMergeIntegration_collection_shard1_replica_n1\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":7,\n    
\"SEARCHER.searcher.deletedDocs\":5,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":2,\n    \"violationType\":\"belowDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":2,\n    \"__bytes__\":1,\n 
   \"shard\":\"shard1\",\n    
\"collection\":\"testMergeIntegration_collection\"}}",
   [junit4]   2>         "{\"core_node3\":{\n    
\"core\":\"testMergeIntegration_collection_shard2_replica_n3\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":3,\n    
\"SEARCHER.searcher.deletedDocs\":0,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":3,\n    \"violationType\":\"belowDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":3,\n    \"__bytes__\":1,\n 
   \"shard\":\"shard2\",\n    
\"collection\":\"testMergeIntegration_collection\"}}"]},
   [junit4]   2>     "_enqueue_time_":74896255278682,
   [junit4]   2>     "requestedOps":["Op{action=MERGESHARDS, 
hints={COLL_SHARD=[{\n  \"first\":\"testMergeIntegration_collection\",\n  
\"second\":\"shard2\"}, {\n  \"first\":\"testMergeIntegration_collection\",\n  
\"second\":\"shard1\"}]}}"]}}, 
context={properties.unsupportedOps=[Op{action=MERGESHARDS, hints={COLL_SHARD=[{
   [junit4]   2>   "first":"testMergeIntegration_collection",
   [junit4]   2>   "second":"shard2"}, {
   [junit4]   2>   "first":"testMergeIntegration_collection",
   [junit4]   2>   "second":"shard1"}]}}], 
properties.BEFORE_ACTION=[compute_plan, execute_plan], 
source=index_size_trigger, properties.AFTER_ACTION=[compute_plan]}, config={
   [junit4]   2>   "trigger":"index_size_trigger",
   [junit4]   2>   "stage":[
   [junit4]   2>     "STARTED",
   [junit4]   2>     "ABORTED",
   [junit4]   2>     "SUCCEEDED",
   [junit4]   2>     "FAILED"],
   [junit4]   2>   "afterAction":[
   [junit4]   2>     "compute_plan",
   [junit4]   2>     "execute_plan"],
   [junit4]   2>   
"class":"org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest$CapturingTriggerListener",
   [junit4]   2>   "beforeAction":[
   [junit4]   2>     "compute_plan",
   [junit4]   2>     "execute_plan"]}, message='null'}
   [junit4]   2> 1522504 DEBUG (AutoscalingActionExecutor-5136-thread-1) [    ] 
o.a.s.c.a.ExecutePlanAction -- processing event: {
   [junit4]   2>   "id":"441a54763f30T3savtrnsa38jr34xhho7g95gv",
   [junit4]   2>   "source":"index_size_trigger",
   [junit4]   2>   "eventTime":74879876874032,
   [junit4]   2>   "eventType":"INDEXSIZE",
   [junit4]   2>   "properties":{
   [junit4]   2>     "__start__":1,
   [junit4]   2>     "aboveSize":{},
   [junit4]   2>     "belowSize":{"testMergeIntegration_collection":[
   [junit4]   2>         "{\"core_node1\":{\n    
\"core\":\"testMergeIntegration_collection_shard1_replica_n1\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":7,\n    
\"SEARCHER.searcher.deletedDocs\":5,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":2,\n    \"violationType\":\"belowDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":2,\n    \"__bytes__\":1,\n 
   \"shard\":\"shard1\",\n    
\"collection\":\"testMergeIntegration_collection\"}}",
   [junit4]   2>         "{\"core_node3\":{\n    
\"core\":\"testMergeIntegration_collection_shard2_replica_n3\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":3,\n    
\"SEARCHER.searcher.deletedDocs\":0,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":3,\n    \"violationType\":\"belowDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":3,\n    \"__bytes__\":1,\n 
   \"shard\":\"shard2\",\n    
\"collection\":\"testMergeIntegration_collection\"}}"]},
   [junit4]   2>     "_enqueue_time_":74896255278682,
   [junit4]   2>     "requestedOps":["Op{action=MERGESHARDS, 
hints={COLL_SHARD=[{\n  \"first\":\"testMergeIntegration_collection\",\n  
\"second\":\"shard2\"}, {\n  \"first\":\"testMergeIntegration_collection\",\n  
\"second\":\"shard1\"}]}}"]}} with context properties: 
{AFTER_ACTION=[compute_plan], unsupportedOps=[Op{action=MERGESHARDS, 
hints={COLL_SHARD=[{
   [junit4]   2>   "first":"testMergeIntegration_collection",
   [junit4]   2>   "second":"shard2"}, {
   [junit4]   2>   "first":"testMergeIntegration_collection",
   [junit4]   2>   "second":"shard1"}]}}], BEFORE_ACTION=[compute_plan, 
execute_plan]}
   [junit4]   2> 1522504 INFO  (AutoscalingActionExecutor-5136-thread-1) [    ] 
o.a.s.c.a.ExecutePlanAction No operations to execute for event: {
   [junit4]   2>   "id":"441a54763f30T3savtrnsa38jr34xhho7g95gv",
   [junit4]   2>   "source":"index_size_trigger",
   [junit4]   2>   "eventTime":74879876874032,
   [junit4]   2>   "eventType":"INDEXSIZE",
   [junit4]   2>   "properties":{
   [junit4]   2>     "__start__":1,
   [junit4]   2>     "aboveSize":{},
   [junit4]   2>     "belowSize":{"testMergeIntegration_collection":[
   [junit4]   2>         "{\"core_node1\":{\n    
\"core\":\"testMergeIntegration_collection_shard1_replica_n1\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":7,\n    
\"SEARCHER.searcher.deletedDocs\":5,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":2,\n    \"violationType\":\"belowDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":2,\n    \"__bytes__\":1,\n 
   \"shard\":\"shard1\",\n    
\"collection\":\"testMergeIntegration_collection\"}}",
   [junit4]   2>         "{\"core_node3\":{\n    
\"core\":\"testMergeIntegration_collection_shard2_replica_n3\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":3,\n    
\"SEARCHER.searcher.deletedDocs\":0,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":3,\n    \"violationType\":\"belowDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":3,\n    \"__bytes__\":1,\n 
   \"shard\":\"shard2\",\n    
\"collection\":\"testMergeIntegration_collection\"}}"]},
   [junit4]   2>     "_enqueue_time_":74896255278682,
   [junit4]   2>     "requestedOps":["Op{action=MERGESHARDS, 
hints={COLL_SHARD=[{\n  \"first\":\"testMergeIntegration_collection\",\n  
\"second\":\"shard2\"}, {\n  \"first\":\"testMergeIntegration_collection\",\n  
\"second\":\"shard1\"}]}}"]}}
   [junit4]   2> 1522505 INFO  (AutoscalingActionExecutor-5136-thread-1) [    ] 
o.a.s.c.a.IndexSizeTriggerTest =======> CapturedEvent{timestamp=74897629870982, 
stage=AFTER_ACTION, actionName='execute_plan', event={
   [junit4]   2>   "id":"441a54763f30T3savtrnsa38jr34xhho7g95gv",
   [junit4]   2>   "source":"index_size_trigger",
   [junit4]   2>   "eventTime":74879876874032,
   [junit4]   2>   "eventType":"INDEXSIZE",
   [junit4]   2>   "properties":{
   [junit4]   2>     "__start__":1,
   [junit4]   2>     "aboveSize":{},
   [junit4]   2>     "belowSize":{"testMergeIntegration_collection":[
   [junit4]   2>         "{\"core_node1\":{\n    
\"core\":\"testMergeIntegration_collection_shard1_replica_n1\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":7,\n    
\"SEARCHER.searcher.deletedDocs\":5,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":2,\n    \"violationType\":\"belowDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":2,\n    \"__bytes__\":1,\n 
   \"shard\":\"shard1\",\n    
\"collection\":\"testMergeIntegration_collection\"}}",
   [junit4]   2>         "{\"core_node3\":{\n    
\"core\":\"testMergeIntegration_collection_shard2_replica_n3\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":3,\n    
\"SEARCHER.searcher.deletedDocs\":0,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":3,\n    \"violationType\":\"belowDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":3,\n    \"__bytes__\":1,\n 
   \"shard\":\"shard2\",\n    
\"collection\":\"testMergeIntegration_collection\"}}"]},
   [junit4]   2>     "_enqueue_time_":74896255278682,
   [junit4]   2>     "requestedOps":["Op{action=MERGESHARDS, 
hints={COLL_SHARD=[{\n  \"first\":\"testMergeIntegration_collection\",\n  
\"second\":\"shard2\"}, {\n  \"first\":\"testMergeIntegration_collection\",\n  
\"second\":\"shard1\"}]}}"]}}, 
context={properties.unsupportedOps=[Op{action=MERGESHARDS, hints={COLL_SHARD=[{
   [junit4]   2>   "first":"testMergeIntegration_collection",
   [junit4]   2>   "second":"shard2"}, {
   [junit4]   2>   "first":"testMergeIntegration_collection",
   [junit4]   2>   "second":"shard1"}]}}], 
properties.BEFORE_ACTION=[compute_plan, execute_plan], 
source=index_size_trigger, properties.AFTER_ACTION=[compute_plan, 
execute_plan]}, config={
   [junit4]   2>   "trigger":"index_size_trigger",
   [junit4]   2>   "stage":[
   [junit4]   2>     "STARTED",
   [junit4]   2>     "ABORTED",
   [junit4]   2>     "SUCCEEDED",
   [junit4]   2>     "FAILED"],
   [junit4]   2>   "afterAction":[
   [junit4]   2>     "compute_plan",
   [junit4]   2>     "execute_plan"],
   [junit4]   2>   
"class":"org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest$CapturingTriggerListener",
   [junit4]   2>   "beforeAction":[
   [junit4]   2>     "compute_plan",
   [junit4]   2>     "execute_plan"]}, message='null'}
   [junit4]   2> 1522505 INFO  (AutoscalingActionExecutor-5136-thread-1) [    ] 
o.a.s.c.a.IndexSizeTriggerTest =======> CapturedEvent{timestamp=74897665131432, 
stage=SUCCEEDED, actionName='null', event={
   [junit4]   2>   "id":"441a54763f30T3savtrnsa38jr34xhho7g95gv",
   [junit4]   2>   "source":"index_size_trigger",
   [junit4]   2>   "eventTime":74879876874032,
   [junit4]   2>   "eventType":"INDEXSIZE",
   [junit4]   2>   "properties":{
   [junit4]   2>     "__start__":1,
   [junit4]   2>     "aboveSize":{},
   [junit4]   2>     "belowSize":{"testMergeIntegration_collection":[
   [junit4]   2>         "{\"core_node1\":{\n    
\"core\":\"testMergeIntegration_collection_shard1_replica_n1\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":7,\n    
\"SEARCHER.searcher.deletedDocs\":5,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":2,\n    \"violationType\":\"belowDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":2,\n    \"__bytes__\":1,\n 
   \"shard\":\"shard1\",\n    
\"collection\":\"testMergeIntegration_collection\"}}",
   [junit4]   2>         "{\"core_node3\":{\n    
\"core\":\"testMergeIntegration_collection_shard2_replica_n3\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":3,\n    
\"SEARCHER.searcher.deletedDocs\":0,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":3,\n    \"violationType\":\"belowDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":3,\n    \"__bytes__\":1,\n 
   \"shard\":\"shard2\",\n    
\"collection\":\"testMergeIntegration_collection\"}}"]},
   [junit4]   2>     "_enqueue_time_":74896255278682,
   [junit4]   2>     "requestedOps":["Op{action=MERGESHARDS, 
hints={COLL_SHARD=[{\n  \"first\":\"testMergeIntegration_collection\",\n  
\"second\":\"shard2\"}, {\n  \"first\":\"testMergeIntegration_collection\",\n  
\"second\":\"shard1\"}]}}"]}}, context={}, config={
   [junit4]   2>   "trigger":"index_size_trigger",
   [junit4]   2>   "stage":[
   [junit4]   2>     "STARTED",
   [junit4]   2>     "ABORTED",
   [junit4]   2>     "SUCCEEDED",
   [junit4]   2>     "FAILED"],
   [junit4]   2>   "afterAction":[
   [junit4]   2>     "compute_plan",
   [junit4]   2>     "execute_plan"],
   [junit4]   2>   
"class":"org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest$CapturingTriggerListener",
   [junit4]   2>   "beforeAction":[
   [junit4]   2>     "compute_plan",
   [junit4]   2>     "execute_plan"]}, message='null'}
   [junit4]   2> 1522510 INFO  
(TEST-IndexSizeTriggerTest.testMergeIntegration-seed#[9099CE97C674347B]) [    ] 
o.a.s.c.a.IndexSizeTriggerTest #######################################
   [junit4]   2> ############ CLUSTER STATE ############
   [junit4]   2> #######################################
   [junit4]   2> ## Live nodes:         2
   [junit4]   2> ## Empty nodes:        0
   [junit4]   2> ## Dead nodes:         0
   [junit4]   2> ## Collections:        [testMergeIntegration_collection]
   [junit4]   2> 
DocCollection(testMergeIntegration_collection//clusterstate.json/50)={
   [junit4]   2>   "replicationFactor":"2",
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"2",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"2",
   [junit4]   2>   "tlogReplicas":"0",
   [junit4]   2>   "autoCreated":"true",
   [junit4]   2>   "shards":{
   [junit4]   2>     "shard2":{
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node3":{
   [junit4]   2>           
"core":"testMergeIntegration_collection_shard2_replica_n3",
   [junit4]   2>           "leader":"true",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":3,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":1,
   [junit4]   2>           "node_name":"127.0.0.1:10001_solr",
   [junit4]   2>           "state":"active",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.numDocs":3},
   [junit4]   2>         "core_node4":{
   [junit4]   2>           
"core":"testMergeIntegration_collection_shard2_replica_n4",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":3,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":1,
   [junit4]   2>           "node_name":"127.0.0.1:10000_solr",
   [junit4]   2>           "state":"active",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.numDocs":3}},
   [junit4]   2>       "range":"0-7fffffff",
   [junit4]   2>       "state":"active"},
   [junit4]   2>     "shard1":{
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node1":{
   [junit4]   2>           
"core":"testMergeIntegration_collection_shard1_replica_n1",
   [junit4]   2>           "leader":"true",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":7,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":5,
   [junit4]   2>           "INDEX.sizeInBytes":1,
   [junit4]   2>           "node_name":"127.0.0.1:10001_solr",
   [junit4]   2>           "state":"active",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.numDocs":2},
   [junit4]   2>         "core_node2":{
   [junit4]   2>           
"core":"testMergeIntegration_collection_shard1_replica_n2",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":7,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":5,
   [junit4]   2>           "INDEX.sizeInBytes":1,
   [junit4]   2>           "node_name":"127.0.0.1:10000_solr",
   [junit4]   2>           "state":"active",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.numDocs":2}},
   [junit4]   2>       "range":"80000000-ffffffff",
   [junit4]   2>       "state":"active"}}}
   [junit4]   2> ## Max replicas per node:      2
   [junit4]   2> ## Min replicas per node:      2
   [junit4]   2> ## Total replicas:             4
   [junit4]   2> ## * testMergeIntegration_collection           4
   [junit4]   2> ##             - active           4
   [junit4]   2> ######### Solr op counts ##########
   [junit4]   2> ##             - CREATE             1
   [junit4]   2> ##             - autoscaling        3
   [junit4]   2> ##             - update            18
   [junit4]   2> ######### Autoscaling event counts ###########
   [junit4]   2> ## * Trigger: index_size_trigger
   [junit4]   2> ##             - STARTED         1
   [junit4]   2> 
   [junit4]   2> 1522510 DEBUG 
(TEST-IndexSizeTriggerTest.testMergeIntegration-seed#[9099CE97C674347B]) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
6
   [junit4]   2> 1522510 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 6
   [junit4]   2> 1522513 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
   [junit4]   2> 1522513 DEBUG (AutoscalingActionExecutor-5136-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -- processing took 867 ms for event 
id=441a54763f30T3savtrnsa38jr34xhho7g95gv
   [junit4]   2> 1522513 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1522514 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 6, lastZnodeVersion 6
   [junit4]   2> 1522621 INFO  
(TEST-IndexSizeTriggerTest.testMergeIntegration-seed#[9099CE97C674347B]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testMergeIntegration
   [junit4]   2> 1522685 INFO  
(TEST-IndexSizeTriggerTest.testSplitIntegration-seed#[9099CE97C674347B]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testSplitIntegration
   [junit4]   2> 1522733 DEBUG (simCloudManagerPool-5134-thread-69) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for 
testSplitIntegration_collection / shard1: {"core_node1":{
   [junit4]   2>     "core":"testSplitIntegration_collection_shard1_replica_n1",
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>     "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>     "INDEX.sizeInBytes":1,
   [junit4]   2>     "node_name":"127.0.0.1:10001_solr",
   [junit4]   2>     "state":"active",
   [junit4]   2>     "type":"NRT",
   [junit4]   2>     "SEARCHER.searcher.numDocs":0,
   [junit4]   2>     "shard":"shard1",
   [junit4]   2>     "collection":"testSplitIntegration_collection"}}
   [junit4]   2> 1522769 DEBUG (simCloudManagerPool-5134-thread-70) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1522769 DEBUG (simCloudManagerPool-5134-thread-70) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
7
   [junit4]   2> 1522770 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 7
   [junit4]   2> 1522770 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
   [junit4]   2> 1522770 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1522770 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 7, lastZnodeVersion 7
   [junit4]   2> 1522786 DEBUG (simCloudManagerPool-5134-thread-71) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1522786 DEBUG (simCloudManagerPool-5134-thread-71) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
8
   [junit4]   2> 1522786 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 8
   [junit4]   2> 1522787 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
   [junit4]   2> 1522787 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1522787 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 8, lastZnodeVersion 8
   [junit4]   2> 1522798 DEBUG (simCloudManagerPool-5134-thread-72) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1522798 DEBUG (simCloudManagerPool-5134-thread-72) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
9
   [junit4]   2> 1522799 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 9
   [junit4]   2> 1522799 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
   [junit4]   2> 1522799 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1522799 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 9, lastZnodeVersion 9
   [junit4]   2> 1522924 DEBUG (ScheduledTrigger-5135-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown inactive - processing event: {
   [junit4]   2>   "id":"4421903de44eT3savtrnsa38jr34xhho7g95gy",
   [junit4]   2>   "source":"index_size_trigger",
   [junit4]   2>   "eventTime":74910944584782,
   [junit4]   2>   "eventType":"INDEXSIZE",
   [junit4]   2>   "properties":{
   [junit4]   2>     
"aboveSize":{"testSplitIntegration_collection":["{\"core_node1\":{\n    
\"core\":\"testSplitIntegration_collection_shard1_replica_n1\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":14,\n    
\"SEARCHER.searcher.deletedDocs\":0,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":14,\n    \"violationType\":\"aboveDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":14,\n    
\"__bytes__\":1,\n    \"shard\":\"shard1\",\n    
\"collection\":\"testSplitIntegration_collection\"}}"]},
   [junit4]   2>     "belowSize":{},
   [junit4]   2>     "requestedOps":["Op{action=SPLITSHARD, 
hints={COLL_SHARD=[{\n  \"first\":\"testSplitIntegration_collection\",\n  
\"second\":\"shard1\"}]}}"]}}
   [junit4]   2> 1522924 DEBUG (ScheduledTrigger-5135-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers Pausing all triggers: [index_size_trigger]
   [junit4]   2> 1522925 INFO  (ScheduledTrigger-5135-thread-3) [    ] 
o.a.s.c.a.IndexSizeTriggerTest =======> CapturedEvent{timestamp=74918629663682, 
stage=STARTED, actionName='null', event={
   [junit4]   2>   "id":"4421903de44eT3savtrnsa38jr34xhho7g95gy",
   [junit4]   2>   "source":"index_size_trigger",
   [junit4]   2>   "eventTime":74910944584782,
   [junit4]   2>   "eventType":"INDEXSIZE",
   [junit4]   2>   "properties":{
   [junit4]   2>     
"aboveSize":{"testSplitIntegration_collection":["{\"core_node1\":{\n    
\"core\":\"testSplitIntegration_collection_shard1_replica_n1\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":14,\n    
\"SEARCHER.searcher.deletedDocs\":0,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":14,\n    \"violationType\":\"aboveDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":14,\n    
\"__bytes__\":1,\n    \"shard\":\"shard1\",\n    
\"collection\":\"testSplitIntegration_collection\"}}"]},
   [junit4]   2>     "belowSize":{},
   [junit4]   2>     "_enqueue_time_":74918620010582,
   [junit4]   2>     "requestedOps":["Op{action=SPLITSHARD, 
hints={COLL_SHARD=[{\n  \"first\":\"testSplitIntegration_collection\",\n  
\"second\":\"shard1\"}]}}"]}}, context={}, config={
   [junit4]   2>   "trigger":"index_size_trigger",
   [junit4]   2>   "stage":[
   [junit4]   2>     "STARTED",
   [junit4]   2>     "ABORTED",
   [junit4]   2>     "SUCCEEDED",
   [junit4]   2>     "FAILED"],
   [junit4]   2>   "afterAction":[
   [junit4]   2>     "compute_plan",
   [junit4]   2>     "execute_plan"],
   [junit4]   2>   
"class":"org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest$CapturingTriggerListener",
   [junit4]   2>   "beforeAction":[
   [junit4]   2>     "compute_plan",
   [junit4]   2>     "execute_plan"]}, message='null'}
   [junit4]   2> 1522926 DEBUG (AutoscalingActionExecutor-5136-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -- processing actions for {
   [junit4]   2>   "id":"4421903de44eT3savtrnsa38jr34xhho7g95gy",
   [junit4]   2>   "source":"index_size_trigger",
   [junit4]   2>   "eventTime":74910944584782,
   [junit4]   2>   "eventType":"INDEXSIZE",
   [junit4]   2>   "properties":{
   [junit4]   2>     
"aboveSize":{"testSplitIntegration_collection":["{\"core_node1\":{\n    
\"core\":\"testSplitIntegration_collection_shard1_replica_n1\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":14,\n    
\"SEARCHER.searcher.deletedDocs\":0,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":14,\n    \"violationType\":\"aboveDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":14,\n    
\"__bytes__\":1,\n    \"shard\":\"shard1\",\n    
\"collection\":\"testSplitIntegration_collection\"}}"]},
   [junit4]   2>     "belowSize":{},
   [junit4]   2>     "_enqueue_time_":74918620010582,
   [junit4]   2>     "requestedOps":["Op{action=SPLITSHARD, 
hints={COLL_SHARD=[{\n  \"first\":\"testSplitIntegration_collection\",\n  
\"second\":\"shard1\"}]}}"]}}
   [junit4]   2> 1522926 INFO  (AutoscalingActionExecutor-5136-thread-1) [    ] 
o.a.s.c.a.IndexSizeTriggerTest =======> CapturedEvent{timestamp=74918717162982, 
stage=BEFORE_ACTION, actionName='compute_plan', event={
   [junit4]   2>   "id":"4421903de44eT3savtrnsa38jr34xhho7g95gy",
   [junit4]   2>   "source":"index_size_trigger",
   [junit4]   2>   "eventTime":74910944584782,
   [junit4]   2>   "eventType":"INDEXSIZE",
   [junit4]   2>   "properties":{
   [junit4]   2>     
"aboveSize":{"testSplitIntegration_collection":["{\"core_node1\":{\n    
\"core\":\"testSplitIntegration_collection_shard1_replica_n1\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":14,\n    
\"SEARCHER.searcher.deletedDocs\":0,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":14,\n    \"violationType\":\"aboveDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":14,\n    
\"__bytes__\":1,\n    \"shard\":\"shard1\",\n    
\"collection\":\"testSplitIntegration_collection\"}}"]},
   [junit4]   2>     "belowSize":{},
   [junit4]   2>     "_enqueue_time_":74918620010582,
   [junit4]   2>     "requestedOps":["Op{action=SPLITSHARD, 
hints={COLL_SHARD=[{\n  \"first\":\"testSplitIntegration_collection\",\n  
\"second\":\"shard1\"}]}}"]}}, 
context={properties.BEFORE_ACTION=[compute_plan], source=index_size_trigger}, 
config={
   [junit4]   2>   "trigger":"index_size_trigger",
   [junit4]   2>   "stage":[
   [junit4]   2>     "STARTED",
   [junit4]   2>     "ABORTED",
   [junit4]   2>     "SUCCEEDED",
   [junit4]   2>     "FAILED"],
   [junit4]   2>   "afterAction":[
   [junit4]   2>     "compute_plan",
   [junit4]   2>     "execute_plan"],
   [junit4]   2>   
"class":"org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest$CapturingTriggerListener",
   [junit4]   2>   "beforeAction":[
   [junit4]   2>     "compute_plan",
   [junit4]   2>     "execute_plan"]}, message='null'}
   [junit4]   2> 1522926 DEBUG (AutoscalingActionExecutor-5136-thread-1) [    ] 
o.a.s.c.a.ComputePlanAction -- processing event: {
   [junit4]   2>   "id":"4421903de44eT3savtrnsa38jr34xhho7g95gy",
   [junit4]   2>   "source":"index_size_trigger",
   [junit4]   2>   "eventTime":74910944584782,
   [junit4]   2>   "eventType":"INDEXSIZE",
   [junit4]   2>   "properties":{
   [junit4]   2>     
"aboveSize":{"testSplitIntegration_collection":["{\"core_node1\":{\n    
\"core\":\"testSplitIntegration_collection_shard1_replica_n1\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":14,\n    
\"SEARCHER.searcher.deletedDocs\":0,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":14,\n    \"violationType\":\"aboveDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":14,\n    
\"__bytes__\":1,\n    \"shard\":\"shard1\",\n    
\"collection\":\"testSplitIntegration_collection\"}}"]},
   [junit4]   2>     "belowSize":{},
   [junit4]   2>     "_enqueue_time_":74918620010582,
   [junit4]   2>     "requestedOps":["Op{action=SPLITSHARD, 
hints={COLL_SHARD=[{\n  \"first\":\"testSplitIntegration_collection\",\n  
\"second\":\"shard1\"}]}}"]}} with context properties: 
{BEFORE_ACTION=[compute_plan]}
   [junit4]   2> 1522928 INFO  (AutoscalingActionExecutor-5136-thread-1) [    ] 
o.a.s.c.a.ComputePlanAction Computed Plan: 
action=SPLITSHARD&collection=testSplitIntegration_collection&shard=shard1
   [junit4]   2> 1522928 INFO  (AutoscalingActionExecutor-5136-thread-1) [    ] 
o.a.s.c.s.c.a.PolicyHelper returnSession, curr-time 74918825 
sessionWrapper.createTime 74918749065832, this.sessionWrapper.createTime 
74918749065832 
   [junit4]   2> 1522929 INFO  (AutoscalingActionExecutor-5136-thread-1) [    ] 
o.a.s.c.a.IndexSizeTriggerTest =======> CapturedEvent{timestamp=74918828104832, 
stage=AFTER_ACTION, actionName='compute_plan', event={
   [junit4]   2>   "id":"4421903de44eT3savtrnsa38jr34xhho7g95gy",
   [junit4]   2>   "source":"index_size_trigger",
   [junit4]   2>   "eventTime":74910944584782,
   [junit4]   2>   "eventType":"INDEXSIZE",
   [junit4]   2>   "properties":{
   [junit4]   2>     "__start__":1,
   [junit4]   2>     
"aboveSize":{"testSplitIntegration_collection":["{\"core_node1\":{\n    
\"core\":\"testSplitIntegration_collection_shard1_replica_n1\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":14,\n    
\"SEARCHER.searcher.deletedDocs\":0,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":14,\n    \"violationType\":\"aboveDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":14,\n    
\"__bytes__\":1,\n    \"shard\":\"shard1\",\n    
\"collection\":\"testSplitIntegration_collection\"}}"]},
   [junit4]   2>     "belowSize":{},
   [junit4]   2>     "_enqueue_time_":74918620010582,
   [junit4]   2>     "requestedOps":["Op{action=SPLITSHARD, 
hints={COLL_SHARD=[{\n  \"first\":\"testSplitIntegration_collection\",\n  
\"second\":\"shard1\"}]}}"]}}, 
context={properties.operations=[{class=org.apache.solr.client.solrj.request.CollectionAdminRequest$SplitShard,
 method=GET, params.action=SPLITSHARD, 
params.collection=testSplitIntegration_collection, params.shard=shard1}], 
properties.BEFORE_ACTION=[compute_plan], source=index_size_trigger, 
properties.AFTER_ACTION=[compute_plan]}, config={
   [junit4]   2>   "trigger":"index_size_trigger",
   [junit4]   2>   "stage":[
   [junit4]   2>     "STARTED",
   [junit4]   2>     "ABORTED",
   [junit4]   2>     "SUCCEEDED",
   [junit4]   2>     "FAILED"],
   [junit4]   2>   "afterAction":[
   [junit4]   2>     "compute_plan",
   [junit4]   2>     "execute_plan"],
   [junit4]   2>   
"class":"org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest$CapturingTriggerListener",
   [junit4]   2>   "beforeAction":[
   [junit4]   2>     "compute_plan",
   [junit4]   2>     "execute_plan"]}, message='null'}
   [junit4]   2> 1522929 INFO  (AutoscalingActionExecutor-5136-thread-1) [    ] 
o.a.s.c.a.IndexSizeTriggerTest =======> CapturedEvent{timestamp=74918844046532, 
stage=BEFORE_ACTION, actionName='execute_plan', event={
   [junit4]   2>   "id":"4421903de44eT3savtrnsa38jr34xhho7g95gy",
   [junit4]   2>   "source":"index_size_trigger",
   [junit4]   2>   "eventTime":74910944584782,
   [junit4]   2>   "eventType":"INDEXSIZE",
   [junit4]   2>   "properties":{
   [junit4]   2>     "__start__":1,
   [junit4]   2>     
"aboveSize":{"testSplitIntegration_collection":["{\"core_node1\":{\n    
\"core\":\"testSplitIntegration_collection_shard1_replica_n1\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":14,\n    
\"SEARCHER.searcher.deletedDocs\":0,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":14,\n    \"violationType\":\"aboveDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":14,\n    
\"__bytes__\":1,\n    \"shard\":\"shard1\",\n    
\"collection\":\"testSplitIntegration_collection\"}}"]},
   [junit4]   2>     "belowSize":{},
   [junit4]   2>     "_enqueue_time_":74918620010582,
   [junit4]   2>     "requestedOps":["Op{action=SPLITSHARD, 
hints={COLL_SHARD=[{\n  \"first\":\"testSplitIntegration_collection\",\n  
\"second\":\"shard1\"}]}}"]}}, 
context={properties.operations=[{class=org.apache.solr.client.solrj.request.CollectionAdminRequest$SplitShard,
 method=GET, params.action=SPLITSHARD, 
params.collection=testSplitIntegration_collection, params.shard=shard1}], 
properties.BEFORE_ACTION=[compute_plan, execute_plan], 
source=index_size_trigger, properties.AFTER_ACTION=[compute_plan]}, config={
   [junit4]   2>   "trigger":"index_size_trigger",
   [junit4]   2>   "stage":[
   [junit4]   2>     "STARTED",
   [junit4]   2>     "ABORTED",
   [junit4]   2>     "SUCCEEDED",
   [junit4]   2>     "FAILED"],
   [junit4]   2>   "afterAction":[
   [junit4]   2>     "compute_plan",
   [junit4]   2>     "execute_plan"],
   [junit4]   2>   
"class":"org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest$CapturingTriggerListener",
   [junit4]   2>   "beforeAction":[
   [junit4]   2>     "compute_plan",
   [junit4]   2>     "execute_plan"]}, message='null'}
   [junit4]   2> 1522929 DEBUG (AutoscalingActionExecutor-5136-thread-1) [    ] 
o.a.s.c.a.ExecutePlanAction -- processing event: {
   [junit4]   2>   "id":"4421903de44eT3savtrnsa38jr34xhho7g95gy",
   [junit4]   2>   "source":"index_size_trigger",
   [junit4]   2>   "eventTime":74910944584782,
   [junit4]   2>   "eventType":"INDEXSIZE",
   [junit4]   2>   "properties":{
   [junit4]   2>     "__start__":1,
   [junit4]   2>     
"aboveSize":{"testSplitIntegration_collection":["{\"core_node1\":{\n    
\"core\":\"testSplitIntegration_collection_shard1_replica_n1\",\n    
\"leader\":\"true\",\n    \"SEARCHER.searcher.maxDoc\":14,\n    
\"SEARCHER.searcher.deletedDocs\":0,\n    \"INDEX.sizeInBytes\":1,\n    
\"__docs__\":14,\n    \"violationType\":\"aboveDocs\",\n    
\"node_name\":\"127.0.0.1:10001_solr\",\n    \"state\":\"active\",\n    
\"type\":\"NRT\",\n    \"SEARCHER.searcher.numDocs\":14,\n    
\"__bytes__\":1,\n    \"shard\":\"shard1\",\n    
\"collection\":\"testSplitIntegration_collection\"}}"]},
   [junit4]   2>     "belowSize":{},
   [junit4]   2>     "_enqueue_time_":74918620010582,
   [junit4]   2>     "requestedOps":["Op{action=SPLITSHARD, 
hints={COLL_SHARD=[{\n  \"first\":\"testSplitIntegration_collection\",\n  
\"second\":\"shard1\"}]}}"]}} with context properties: 
{operations=[org.apache.solr.client.solrj.request.CollectionAdminRequest$SplitShard@4eb2df8c],
 AFTER_ACTION=[compute_plan], BEFORE_ACTION=[compute_plan, execute_plan]}
   [junit4]   2> 1522929 DEBUG (AutoscalingActionExecutor-5136-thread-1) [    ] 
o.a.s.c.a.ExecutePlanAction Executing operation: 
action=SPLITSHARD&collection=testSplitIntegration_collection&shard=shard1
   [junit4]   2> 1523081 DEBUG (simCloudManagerPool-5134-thread-101) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for 
testSplitIntegration_collection / shard2: {"core_node3":{
   [junit4]   2>     "core":"testSplitIntegration_collection_shard2_replica_n3",
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "SEARCHER.searcher.maxDoc":11,
   [junit4]   2>     "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>     "INDEX.sizeInBytes":1,
   [junit4]   2>     "node_name":"127.0.0.1:10001_solr",
   [junit4]   2>     "state":"active",
   [junit4]   2>     "type":"NRT",
   [junit4]   2>     "SEARCHER.searcher.numDocs":11,
   [junit4]   2>     "shard":"shard2",
   [junit4]   2>     "collection":"testSplitIntegration_collection"}}
   [junit4]   2> 1523084 DEBUG (simCloudManagerPool-5134-thread-103) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for 
testSplitIntegration_collection / shard1_1: {"core_node10":{
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "SEARCHER.searcher.maxDoc":7,
   [junit4]   2>     "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>     "INDEX.sizeInBytes":1,
   [junit4]   2>     "node_name":"127.0.0.1:10000_solr",
   [junit4]   2>     "base_url":"http://127.0.0.1:10000/solr";,
   [junit4]   2>     "state":"active",
   [junit4]   2>     "type":"NRT",
   [junit4]   2>     "SEARCHER.searcher.numDocs":7,
   [junit4]   2>     "core":"testSplitIntegration_collection_shard1_1_replica1",
   [junit4]   2>     "shard":"shard1_1",
   [junit4]   2>     "collection":"testSplitIntegration_collection"}}
   [junit4]   2> 1523085 DEBUG (simCloudManagerPool-5134-thread-104) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for 
testSplitIntegration_collection / shard1_0: {"core_node7":{
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "SEARCHER.searcher.maxDoc":7,
   [junit4]   2>     "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>     "INDEX.sizeInBytes":1,
   [junit4]   2>     "node_name":"127.0.0.1:10001_solr",
   [junit4]   2>     "base_url":"http://127.0.0.1:10001/solr";,
   [junit4]  

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

o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 1523555 INFO  (zkCallback-3866-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 1523555 INFO  (zkCallback-3871-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 1523561 INFO  (jetty-closer-3840-thread-1) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:52591_solr
   [junit4]   2> 1523561 INFO  (jetty-closer-3840-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@1648924a{/solr,null,UNAVAILABLE}
   [junit4]   2> 1523562 INFO  (jetty-closer-3840-thread-2) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 1523564 INFO  (jetty-closer-3840-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 1523564 INFO  (jetty-closer-3840-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=72062494236147718-127.0.0.1:52591_solr-n_0000000000) closing
   [junit4]   2> 1523564 INFO  
(OverseerStateUpdate-72062494236147718-127.0.0.1:52591_solr-n_0000000000) [    
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:52591_solr
   [junit4]   2> 1523564 WARN  
(OverseerAutoScalingTriggerThread-72062494236147718-127.0.0.1:52591_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 1523565 INFO  (zkCallback-3866-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 1523565 INFO  (zkCallback-3857-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 1523566 DEBUG (jetty-closer-3840-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers Shutting down scheduled thread pool executor now
   [junit4]   2> 1523567 DEBUG (jetty-closer-3840-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers Shutting down action executor now
   [junit4]   2> 1523567 DEBUG (jetty-closer-3840-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers Awaiting termination for action executor
   [junit4]   2> 1523567 DEBUG (jetty-closer-3840-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers Awaiting termination for scheduled thread pool 
executor
   [junit4]   2> 1523567 DEBUG (jetty-closer-3840-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers ScheduledTriggers closed completely
   [junit4]   2> 1523567 DEBUG (jetty-closer-3840-thread-1) [    ] 
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> 1523570 INFO  (jetty-closer-3840-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@a3772b6{/solr,null,UNAVAILABLE}
   [junit4]   2> 1523570 INFO  (jetty-closer-3840-thread-1) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 1523572 ERROR 
(SUITE-IndexSizeTriggerTest-seed#[9099CE97C674347B]-worker) [    ] 
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper 
server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 1523572 INFO  
(SUITE-IndexSizeTriggerTest-seed#[9099CE97C674347B]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:52589 52589
   [junit4]   2> 1523612 INFO  (Thread-2465) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:52589 52589
   [junit4]   2> 1523810 WARN  (Thread-2465) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        5       /solr/aliases.json
   [junit4]   2>        5       /solr/clusterprops.json
   [junit4]   2>        2       /solr/security.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        5       /solr/clusterstate.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        5       /solr/live_nodes
   [junit4]   2>        5       /solr/collections
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.IndexSizeTriggerTest_9099CE97C674347B-001
   [junit4]   2> Apr 23, 2018 5:07:13 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=CheapBastard, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@6b709aa0),
 locale=es-EC, timezone=Pacific/Niue
   [junit4]   2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 1.8.0_144 
(64-bit)/cpus=3,threads=1,free=237137808,total=471334912
   [junit4]   2> NOTE: All tests run in this JVM: [TestDistributedGrouping, 
TestTolerantUpdateProcessorRandomCloud, DocValuesMissingTest, 
TestDFRSimilarityFactory, TestSolrQueryParser, HighlighterConfigTest, 
BasicFunctionalityTest, SpellPossibilityIteratorTest, TestCloudRecovery, 
HdfsTlogReplayBufferedWhileIndexingTest, TestCloudConsistency, 
SolrMetricsIntegrationTest, TestComplexPhraseQParserPlugin, 
TestCloudManagedSchema, TriggerCooldownIntegrationTest, ConnectionReuseTest, 
AddBlockUpdateTest, TestManagedStopFilterFactory, DocValuesTest, 
VMParamsZkACLAndCredentialsProvidersTest, TestSolr4Spatial, 
TestLegacyNumericUtils, SpellCheckComponentTest, MetricsHandlerTest, 
TestImplicitCoreProperties, DisMaxRequestHandlerTest, 
TestGraphTermsQParserPlugin, TestQuerySenderListener, 
TestManagedSynonymGraphFilterFactory, HttpSolrCallGetCoreTest, 
TestPerFieldSimilarityWithDefaultOverride, TestCloudPivotFacet, 
NumberUtilsTest, TestCollectionAPIs, CdcrReplicationHandlerTest, 
SchemaApiFailureTest, TestStressLucene, TestBadConfig, TestLRUCache, 
TestComponentsName, SuggesterTest, TestSolrFieldCacheBean, CoreSorterTest, 
DistributedSpellCheckComponentTest, MetricUtilsTest, TestStreamBody, 
CachingDirectoryFactoryTest, TestRandomDVFaceting, AnalyticsQueryTest, 
MetricsConfigTest, DefaultValueUpdateProcessorTest, BooleanFieldTest, TestSort, 
TestDistributedMissingSort, URLClassifyProcessorTest, PreAnalyzedFieldTest, 
HdfsCollectionsAPIDistributedZkTest, QueryResultKeyTest, TestSolrCLIRunExample, 
TestStressInPlaceUpdates, TimeRoutedAliasUpdateProcessorTest, 
SolrJmxReporterTest, TestDirectoryFactory, TestInitQParser, 
TestCollectionsAPIViaSolrCloudCluster, LeaderFailoverAfterPartitionTest, 
DocValuesMultiTest, TestPrepRecovery, TestEmbeddedSolrServerSchemaAPI, 
TimeZoneUtilsTest, TestReversedWildcardFilterFactory, TestConfigOverlay, 
TestAuthorizationFramework, UpdateLogTest, TestRestoreCore, 
PreAnalyzedUpdateProcessorTest, TestObjectReleaseTracker, 
TestSchemaNameResource, TlogReplayBufferedWhileIndexingTest, 
SpatialRPTFieldTypeTest, FullHLLTest, PrimitiveFieldTypeTest, 
TestLuceneMatchVersion, TestReplicationHandlerBackup, MoveReplicaTest, 
TestFieldCacheVsDocValues, CollectionStateFormat2Test, ReplaceNodeNoTargetTest, 
TestStressRecovery, JSONWriterTest, TestCloudNestedDocsSort, TestManagedSchema, 
TestSizeLimitedDistributedMap, NodeLostTriggerTest, 
FullSolrCloudDistribCmdsTest, TestPullReplicaErrorHandling, 
TestSolrConfigHandlerConcurrent, SaslZkACLProviderTest, TestDistributedSearch, 
TestSegmentSorting, DistribDocExpirationUpdateProcessorTest, TestExportWriter, 
TestDFISimilarityFactory, CdcrVersionReplicationTest, JsonLoaderTest, 
HighlighterMaxOffsetTest, TestNumericTerms64, SolrCoreCheckLockOnStartupTest, 
EchoParamsTest, TestMiniSolrCloudClusterSSL, SliceStateTest, 
TestDefaultStatsCache, DistributedFacetSimpleRefinementLongTailTest, 
StatsReloadRaceTest, TestMultiValuedNumericRangeQuery, TestMultiWordSynonyms, 
SimpleCollectionCreateDeleteTest, UpdateRequestProcessorFactoryTest, 
BadIndexSchemaTest, UUIDFieldTest, QueryParsingTest, 
ChaosMonkeyNothingIsSafeWithPullReplicasTest, AutoscalingHistoryHandlerTest, 
TestClusterProperties, TestSerializedLuceneMatchVersion, 
RestoreTriggerStateTest, TestFieldTypeCollectionResource, 
TestRequestForwarding, CSVRequestHandlerTest, DistributedTermsComponentTest, 
TestOverriddenPrefixQueryForCustomFieldType, AutoAddReplicasPlanActionTest, 
FileBasedSpellCheckerTest, CircularListTest, TestSubQueryTransformerDistrib, 
CollectionReloadTest, SearchRateTriggerIntegrationTest, 
CloneFieldUpdateProcessorFactoryTest, TestInPlaceUpdatesStandalone, 
TestManagedSchemaThreadSafety, ZkControllerTest, OverseerRolesTest, 
TestPushWriter, TestReloadAndDeleteDocs, HttpPartitionTest, 
TestGraphMLResponseWriter, ZkStateWriterTest, TestFieldCacheSort, 
LeaderVoteWaitTimeoutTest, TestLMJelinekMercerSimilarityFactory, 
TestPayloadScoreQParserPlugin, ScheduledTriggerIntegrationTest, 
SoftAutoCommitTest, AssignBackwardCompatibilityTest, 
ShowFileRequestHandlerTest, SuggestComponentContextFilterQueryTest, 
HealthCheckHandlerTest, IndexSizeTriggerTest]
   [junit4] Completed [313/804 (1!)] on J1 in 5.03s, 4 tests, 1 error <<< 
FAILURES!

[...truncated 11160 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/build.xml:633: The following 
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/build.xml:128: Found 1 
violations in source files (File uses Mockito but has no assumeWorkingMockito() 
call).

Total time: 95 minutes 22 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Setting 
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Setting 
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
Setting 
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to