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

2 tests failed.
FAILED:  
org.apache.solr.cloud.autoscaling.sim.TestSimTriggerIntegration.testListeners

Error Message:
foo events: [CapturedEvent{timestamp=3113434358819647, stage=STARTED, 
actionName='null', event={   "id":"b0fa556fb89a7T4re8cua4ov2kx55qjp3w1g479",   
"source":"node_added_trigger",   "eventTime":3113427547163047,   
"eventType":"NODEADDED",   "properties":{     "eventTimes":[3113427547163047],  
   "preferredOperation":"movereplica",     "_enqueue_time_":3113431256431697,   
  "nodeNames":["127.0.0.1:10458_solr"]}}, context={}, config={   
"trigger":"node_added_trigger",   "stage":[     "STARTED",     "ABORTED",     
"SUCCEEDED",     "FAILED"],   "beforeAction":"test",   "afterAction":[     
"test",     "test1"],   
"class":"org.apache.solr.cloud.autoscaling.sim.TestSimTriggerIntegration$TestTriggerListener"},
 message='null'}, CapturedEvent{timestamp=3113434415471197, 
stage=BEFORE_ACTION, actionName='test', event={   
"id":"b0fa556fb89a7T4re8cua4ov2kx55qjp3w1g479",   
"source":"node_added_trigger",   "eventTime":3113427547163047,   
"eventType":"NODEADDED",   "properties":{     "eventTimes":[3113427547163047],  
   "preferredOperation":"movereplica",     "_enqueue_time_":3113431256431697,   
  "nodeNames":["127.0.0.1:10458_solr"]}}, 
context={properties.BEFORE_ACTION=[test, test1], source=node_added_trigger}, 
config={   "trigger":"node_added_trigger",   "stage":[     "STARTED",     
"ABORTED",     "SUCCEEDED",     "FAILED"],   "beforeAction":"test",   
"afterAction":[     "test",     "test1"],   
"class":"org.apache.solr.cloud.autoscaling.sim.TestSimTriggerIntegration$TestTriggerListener"},
 message='null'}, CapturedEvent{timestamp=3113434907535297, stage=AFTER_ACTION, 
actionName='test', event={   "id":"b0fa556fb89a7T4re8cua4ov2kx55qjp3w1g479",   
"source":"node_added_trigger",   "eventTime":3113427547163047,   
"eventType":"NODEADDED",   "properties":{     "eventTimes":[3113427547163047],  
   "preferredOperation":"movereplica",     "_enqueue_time_":3113431256431697,   
  "nodeNames":["127.0.0.1:10458_solr"]}}, 
context={properties.BEFORE_ACTION=[test, test1], source=node_added_trigger, 
properties.AFTER_ACTION=[test, test1]}, config={   
"trigger":"node_added_trigger",   "stage":[     "STARTED",     "ABORTED",     
"SUCCEEDED",     "FAILED"],   "beforeAction":"test",   "afterAction":[     
"test",     "test1"],   
"class":"org.apache.solr.cloud.autoscaling.sim.TestSimTriggerIntegration$TestTriggerListener"},
 message='null'}, CapturedEvent{timestamp=3113434909202447, stage=AFTER_ACTION, 
actionName='test1', event={   "id":"b0fa556fb89a7T4re8cua4ov2kx55qjp3w1g479",   
"source":"node_added_trigger",   "eventTime":3113427547163047,   
"eventType":"NODEADDED",   "properties":{     "eventTimes":[3113427547163047],  
   "preferredOperation":"movereplica",     "_enqueue_time_":3113431256431697,   
  "nodeNames":["127.0.0.1:10458_solr"]}}, 
context={properties.BEFORE_ACTION=[test, test1], source=node_added_trigger, 
properties.AFTER_ACTION=[test, test1]}, config={   
"trigger":"node_added_trigger",   "stage":[     "STARTED",     "ABORTED",     
"SUCCEEDED",     "FAILED"],   "beforeAction":"test",   "afterAction":[     
"test",     "test1"],   
"class":"org.apache.solr.cloud.autoscaling.sim.TestSimTriggerIntegration$TestTriggerListener"},
 message='null'}] expected:<5> but was:<4>

Stack Trace:
java.lang.AssertionError: foo events: 
[CapturedEvent{timestamp=3113434358819647, stage=STARTED, actionName='null', 
event={
  "id":"b0fa556fb89a7T4re8cua4ov2kx55qjp3w1g479",
  "source":"node_added_trigger",
  "eventTime":3113427547163047,
  "eventType":"NODEADDED",
  "properties":{
    "eventTimes":[3113427547163047],
    "preferredOperation":"movereplica",
    "_enqueue_time_":3113431256431697,
    "nodeNames":["127.0.0.1:10458_solr"]}}, context={}, config={
  "trigger":"node_added_trigger",
  "stage":[
    "STARTED",
    "ABORTED",
    "SUCCEEDED",
    "FAILED"],
  "beforeAction":"test",
  "afterAction":[
    "test",
    "test1"],
  
"class":"org.apache.solr.cloud.autoscaling.sim.TestSimTriggerIntegration$TestTriggerListener"},
 message='null'}, CapturedEvent{timestamp=3113434415471197, 
stage=BEFORE_ACTION, actionName='test', event={
  "id":"b0fa556fb89a7T4re8cua4ov2kx55qjp3w1g479",
  "source":"node_added_trigger",
  "eventTime":3113427547163047,
  "eventType":"NODEADDED",
  "properties":{
    "eventTimes":[3113427547163047],
    "preferredOperation":"movereplica",
    "_enqueue_time_":3113431256431697,
    "nodeNames":["127.0.0.1:10458_solr"]}}, 
context={properties.BEFORE_ACTION=[test, test1], source=node_added_trigger}, 
config={
  "trigger":"node_added_trigger",
  "stage":[
    "STARTED",
    "ABORTED",
    "SUCCEEDED",
    "FAILED"],
  "beforeAction":"test",
  "afterAction":[
    "test",
    "test1"],
  
"class":"org.apache.solr.cloud.autoscaling.sim.TestSimTriggerIntegration$TestTriggerListener"},
 message='null'}, CapturedEvent{timestamp=3113434907535297, stage=AFTER_ACTION, 
actionName='test', event={
  "id":"b0fa556fb89a7T4re8cua4ov2kx55qjp3w1g479",
  "source":"node_added_trigger",
  "eventTime":3113427547163047,
  "eventType":"NODEADDED",
  "properties":{
    "eventTimes":[3113427547163047],
    "preferredOperation":"movereplica",
    "_enqueue_time_":3113431256431697,
    "nodeNames":["127.0.0.1:10458_solr"]}}, 
context={properties.BEFORE_ACTION=[test, test1], source=node_added_trigger, 
properties.AFTER_ACTION=[test, test1]}, config={
  "trigger":"node_added_trigger",
  "stage":[
    "STARTED",
    "ABORTED",
    "SUCCEEDED",
    "FAILED"],
  "beforeAction":"test",
  "afterAction":[
    "test",
    "test1"],
  
"class":"org.apache.solr.cloud.autoscaling.sim.TestSimTriggerIntegration$TestTriggerListener"},
 message='null'}, CapturedEvent{timestamp=3113434909202447, stage=AFTER_ACTION, 
actionName='test1', event={
  "id":"b0fa556fb89a7T4re8cua4ov2kx55qjp3w1g479",
  "source":"node_added_trigger",
  "eventTime":3113427547163047,
  "eventType":"NODEADDED",
  "properties":{
    "eventTimes":[3113427547163047],
    "preferredOperation":"movereplica",
    "_enqueue_time_":3113431256431697,
    "nodeNames":["127.0.0.1:10458_solr"]}}, 
context={properties.BEFORE_ACTION=[test, test1], source=node_added_trigger, 
properties.AFTER_ACTION=[test, test1]}, config={
  "trigger":"node_added_trigger",
  "stage":[
    "STARTED",
    "ABORTED",
    "SUCCEEDED",
    "FAILED"],
  "beforeAction":"test",
  "afterAction":[
    "test",
    "test1"],
  
"class":"org.apache.solr.cloud.autoscaling.sim.TestSimTriggerIntegration$TestTriggerListener"},
 message='null'}] expected:<5> but was:<4>
        at 
__randomizedtesting.SeedInfo.seed([C5DF466912AB72C0:281FD179AFC7EF19]:0)
        at org.junit.Assert.fail(Assert.java:88)
        at org.junit.Assert.failNotEquals(Assert.java:834)
        at org.junit.Assert.assertEquals(Assert.java:645)
        at 
org.apache.solr.cloud.autoscaling.sim.TestSimTriggerIntegration.testListeners(TestSimTriggerIntegration.java:1015)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)


FAILED:  
org.apache.solr.client.solrj.io.stream.StreamDecoratorTest.testParallelCommitStream

Error Message:
expected:<5> but was:<3>

Stack Trace:
java.lang.AssertionError: expected:<5> but was:<3>
        at 
__randomizedtesting.SeedInfo.seed([83A76DFB87A23EC0:A34D0FFB1BE3D38C]:0)
        at org.junit.Assert.fail(Assert.java:88)
        at org.junit.Assert.failNotEquals(Assert.java:834)
        at org.junit.Assert.assertEquals(Assert.java:645)
        at org.junit.Assert.assertEquals(Assert.java:631)
        at 
org.apache.solr.client.solrj.io.stream.StreamDecoratorTest.testParallelCommitStream(StreamDecoratorTest.java:3034)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 14493 lines...]
   [junit4] Suite: 
org.apache.solr.cloud.autoscaling.sim.TestSimTriggerIntegration
   [junit4]   2> Creating dataDir: 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.sim.TestSimTriggerIntegration_C5DF466912AB72C0-001/init-core-data-001
   [junit4] IGNOR/A 0.00s J0 | TestSimTriggerIntegration.testNodeLostTrigger
   [junit4]    > Assumption #1: 'awaitsfix' test group is disabled 
(@AwaitsFix(bugUrl=https://issues.apache.org/jira/browse/SOLR-12028))
   [junit4]   2> 2127741 DEBUG 
(TEST-TestSimTriggerIntegration.testListeners-seed#[C5DF466912AB72C0]) [    ] 
o.a.s.c.a.s.SimClusterStateProvider --- new Overseer leader: 
127.0.0.1:10456_solr
   [junit4]   2> 2127742 DEBUG 
(TEST-TestSimTriggerIntegration.testListeners-seed#[C5DF466912AB72C0]) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=0
   [junit4]   2> 2127742 DEBUG 
(TEST-TestSimTriggerIntegration.testListeners-seed#[C5DF466912AB72C0]) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 0
   [junit4]   2> 2127742 INFO  
(TEST-TestSimTriggerIntegration.testListeners-seed#[C5DF466912AB72C0]) [    ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 2127745 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and 
.scheduled_maintenance triggers
   [junit4]   2> 2127745 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode 
version 0
   [junit4]   2> 2127745 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion -1
   [junit4]   2> 2127745 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 0
   [junit4]   2> 2127745 INFO  (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial 
livenodes: [127.0.0.1:10456_solr, 127.0.0.1:10457_solr]
   [junit4]   2> 2127745 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 2127745 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion 0
   [junit4]   2> 2127745 DEBUG (ScheduledTrigger-13410-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 2127750 DEBUG (simCloudManagerPool-13409-thread-4) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 2127750 DEBUG (simCloudManagerPool-13409-thread-4) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
1
   [junit4]   2> 2127756 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
   [junit4]   2> 2127773 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 2127773 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 2127777 DEBUG (ScheduledTrigger-13410-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 2127778 DEBUG (simCloudManagerPool-13409-thread-5) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 2127779 DEBUG (simCloudManagerPool-13409-thread-5) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
2
   [junit4]   2> 2127779 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
   [junit4]   2> 2127779 INFO  (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.s.TestSimTriggerIntegration TestTriggerAction init
   [junit4]   2> 2127779 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger - Initial 
livenodes: [127.0.0.1:10456_solr, 127.0.0.1:10457_solr]
   [junit4]   2> 2127779 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger instantiated 
with properties: {event=nodeAdded, waitFor=3, actions=[{name=test, 
class=org.apache.solr.cloud.autoscaling.sim.TestSimTriggerIntegration$TestTriggerAction},
 {name=test1, 
class=org.apache.solr.cloud.autoscaling.sim.TestSimTriggerIntegration$TestDummyAction}],
 enabled=true}
   [junit4]   2> 2127779 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
   [junit4]   2> 2127779 DEBUG (ScheduledTrigger-13410-thread-2) [    ] 
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
   [junit4]   2> 2127779 DEBUG (ScheduledTrigger-13410-thread-2) [    ] 
o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
   [junit4]   2> 2127786 DEBUG (simCloudManagerPool-13409-thread-6) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 2127786 DEBUG (simCloudManagerPool-13409-thread-6) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
3
   [junit4]   2> 2127786 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 3
   [junit4]   2> 2127786 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion 3
   [junit4]   2> 2127792 DEBUG (simCloudManagerPool-13409-thread-7) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 2127792 DEBUG (simCloudManagerPool-13409-thread-7) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
4
   [junit4]   2> 2127793 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 4
   [junit4]   2> 2127793 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 4, lastZnodeVersion 4
   [junit4]   2> 2127798 DEBUG (ScheduledTrigger-13410-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 3 and last live nodes: 2
   [junit4]   2> 2127806 DEBUG (ScheduledTrigger-13410-thread-4) [    ] 
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
   [junit4]   2> 2127806 DEBUG (ScheduledTrigger-13410-thread-4) [    ] 
o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
   [junit4]   2> 2127806 DEBUG (ScheduledTrigger-13410-thread-4) [    ] 
o.a.s.c.a.NodeAddedTrigger Tracking new node: 127.0.0.1:10458_solr at time 
3113427547163047
   [junit4]   2> 2127833 DEBUG (ScheduledTrigger-13410-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 3 and last live nodes: 3
   [junit4]   2> 2127833 DEBUG (ScheduledTrigger-13410-thread-3) [    ] 
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
   [junit4]   2> 2127833 DEBUG (ScheduledTrigger-13410-thread-3) [    ] 
o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
   [junit4]   2> 2127853 DEBUG (ScheduledTrigger-13410-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 3 and last live nodes: 3
   [junit4]   2> 2127853 DEBUG (ScheduledTrigger-13410-thread-3) [    ] 
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
   [junit4]   2> 2127853 DEBUG (ScheduledTrigger-13410-thread-3) [    ] 
o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
   [junit4]   2> 2127876 DEBUG (ScheduledTrigger-13410-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 3 and last live nodes: 3
   [junit4]   2> 2127876 DEBUG (ScheduledTrigger-13410-thread-3) [    ] 
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
   [junit4]   2> 2127876 DEBUG (ScheduledTrigger-13410-thread-3) [    ] 
o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
   [junit4]   2> 2127876 DEBUG (ScheduledTrigger-13410-thread-3) [    ] 
o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger firing 
registered processor for nodes: [127.0.0.1:10458_solr] added at times 
[3113427547163047], now=3113431071298997
   [junit4]   2> 2127877 DEBUG (ScheduledTrigger-13410-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown inactive - processing event: {
   [junit4]   2>   "id":"b0fa556fb89a7T4re8cua4ov2kx55qjp3w1g479",
   [junit4]   2>   "source":"node_added_trigger",
   [junit4]   2>   "eventTime":3113427547163047,
   [junit4]   2>   "eventType":"NODEADDED",
   [junit4]   2>   "properties":{
   [junit4]   2>     "eventTimes":[3113427547163047],
   [junit4]   2>     "preferredOperation":"movereplica",
   [junit4]   2>     "nodeNames":["127.0.0.1:10458_solr"]}}
   [junit4]   2> 2127880 DEBUG (ScheduledTrigger-13410-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers Pausing all triggers: [.auto_add_replicas, 
node_added_trigger]
   [junit4]   2> 2127883 DEBUG (simCloudManagerPool-13409-thread-8) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- simCreateCollection .system, 
currentVersion=1
   [junit4]   2> 2127883 DEBUG (simCloudManagerPool-13409-thread-8) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=1
   [junit4]   2> 2127883 DEBUG (simCloudManagerPool-13409-thread-8) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 1
   [junit4]   2> 2127897 DEBUG (simCloudManagerPool-13409-thread-8) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=2
   [junit4]   2> 2127897 DEBUG (simCloudManagerPool-13409-thread-8) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 2
   [junit4]   2> 2127909 DEBUG (simCloudManagerPool-13409-thread-11) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=3
   [junit4]   2> 2127909 DEBUG (simCloudManagerPool-13409-thread-11) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 3
   [junit4]   2> 2127920 DEBUG (simCloudManagerPool-13409-thread-10) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=4
   [junit4]   2> 2127921 DEBUG (simCloudManagerPool-13409-thread-10) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 4
   [junit4]   2> 2127927 DEBUG (simCloudManagerPool-13409-thread-13) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for .system / shard1 
(currentVersion=5): {"core_node2":{
   [junit4]   2>     "core":".system_shard1_replica_n2",
   [junit4]   2>     "shard":"shard1",
   [junit4]   2>     "collection":".system",
   [junit4]   2>     "node_name":"127.0.0.1:10458_solr",
   [junit4]   2>     "type":"NRT",
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>     "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>     "INDEX.sizeInBytes":10240,
   [junit4]   2>     "state":"active",
   [junit4]   2>     "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>     "SEARCHER.searcher.numDocs":0}}
   [junit4]   2> 2127941 DEBUG (simCloudManagerPool-13409-thread-9) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=5
   [junit4]   2> 2127941 DEBUG (simCloudManagerPool-13409-thread-9) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 5
   [junit4]   2> 2127941 DEBUG (simCloudManagerPool-13409-thread-8) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- finished createCollection .system, 
currentVersion=6
   [junit4]   2> 2127942 DEBUG (ScheduledTrigger-13410-thread-3) [    ] 
o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger - removing 
marker path: /autoscaling/nodeAdded/127.0.0.1:10458_solr
   [junit4]   2> 2127943 DEBUG (AutoscalingActionExecutor-13411-thread-1) [    
] o.a.s.c.a.ScheduledTriggers -- processing actions for {
   [junit4]   2>   "id":"b0fa556fb89a7T4re8cua4ov2kx55qjp3w1g479",
   [junit4]   2>   "source":"node_added_trigger",
   [junit4]   2>   "eventTime":3113427547163047,
   [junit4]   2>   "eventType":"NODEADDED",
   [junit4]   2>   "properties":{
   [junit4]   2>     "eventTimes":[3113427547163047],
   [junit4]   2>     "preferredOperation":"movereplica",
   [junit4]   2>     "_enqueue_time_":3113431256431697,
   [junit4]   2>     "nodeNames":["127.0.0.1:10458_solr"]}}
   [junit4]   2> 2127944 INFO  (simCloudManagerPool-13409-thread-12) [    ] 
o.a.s.c.ActionThrottle Throttling leader attempts - waiting for 4106ms
   [junit4]   2> 2128017 DEBUG 
(TEST-TestSimTriggerIntegration.testListeners-seed#[C5DF466912AB72C0]) [    ] 
o.a.s.c.a.ScheduledTriggers Shutting down scheduled thread pool executor now
   [junit4]   2> 2128017 INFO  (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are 
closed, exiting.
   [junit4]   2> 2128018 DEBUG 
(TEST-TestSimTriggerIntegration.testListeners-seed#[C5DF466912AB72C0]) [    ] 
o.a.s.c.a.ScheduledTriggers Shutting down action executor now
   [junit4]   2> 2128018 DEBUG 
(TEST-TestSimTriggerIntegration.testListeners-seed#[C5DF466912AB72C0]) [    ] 
o.a.s.c.a.ScheduledTriggers Awaiting termination for action executor
   [junit4]   2> 2128018 WARN  (AutoscalingActionExecutor-13411-thread-1) [    
] o.a.s.c.a.SystemLogListener Exception sending event to collection .system
   [junit4]   2> java.io.IOException: java.lang.InterruptedException
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.sim.SimCloudManager.request(SimCloudManager.java:654)
 ~[test/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.SystemLogListener.onEvent(SystemLogListener.java:118)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:801)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:768)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$null$3(ScheduledTriggers.java:321)
 ~[java/:?]
   [junit4]   2>        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) 
~[?:1.8.0_191]
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[?:1.8.0_191]
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
 ~[java/:?]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) 
[?:1.8.0_191]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) 
[?:1.8.0_191]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_191]
   [junit4]   2> Caused by: java.lang.InterruptedException
   [junit4]   2>        at 
java.util.concurrent.FutureTask.awaitDone(FutureTask.java:404) ~[?:1.8.0_191]
   [junit4]   2>        at 
java.util.concurrent.FutureTask.get(FutureTask.java:191) ~[?:1.8.0_191]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.sim.SimCloudManager.request(SimCloudManager.java:652)
 ~[test/:?]
   [junit4]   2>        ... 10 more
   [junit4]   2> 2128018 DEBUG (AutoscalingActionExecutor-13411-thread-1) [    
] o.a.s.c.a.ScheduledTriggers -- processing took 3779 ms for event 
id=b0fa556fb89a7T4re8cua4ov2kx55qjp3w1g479
   [junit4]   2> 2128018 DEBUG 
(TEST-TestSimTriggerIntegration.testListeners-seed#[C5DF466912AB72C0]) [    ] 
o.a.s.c.a.ScheduledTriggers Awaiting termination for scheduled thread pool 
executor
   [junit4]   2> 2128018 DEBUG 
(TEST-TestSimTriggerIntegration.testListeners-seed#[C5DF466912AB72C0]) [    ] 
o.a.s.c.a.ScheduledTriggers ScheduledTriggers closed completely
   [junit4]   2> 2128018 DEBUG 
(TEST-TestSimTriggerIntegration.testListeners-seed#[C5DF466912AB72C0]) [    ] 
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> 2128019 DEBUG (simCloudManagerPool-13409-thread-12) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for .system / shard1 
(currentVersion=6): {"core_node3":{
   [junit4]   2>     "core":".system_shard1_replica_n3",
   [junit4]   2>     "shard":"shard1",
   [junit4]   2>     "collection":".system",
   [junit4]   2>     "node_name":"127.0.0.1:10456_solr",
   [junit4]   2>     "type":"NRT",
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "SEARCHER.searcher.maxDoc":1,
   [junit4]   2>     "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>     "INDEX.sizeInBytes":10740,
   [junit4]   2>     "state":"active",
   [junit4]   2>     "INDEX.sizeInGB":1.000240445137024E-5,
   [junit4]   2>     "SEARCHER.searcher.numDocs":1}}
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestSimTriggerIntegration -Dtests.method=testListeners 
-Dtests.seed=C5DF466912AB72C0 -Dtests.slow=true -Dtests.locale=ar-SY 
-Dtests.timezone=Antarctica/Troll -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] FAILURE 0.33s J0 | TestSimTriggerIntegration.testListeners <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: foo events: 
[CapturedEvent{timestamp=3113434358819647, stage=STARTED, actionName='null', 
event={
   [junit4]    >   "id":"b0fa556fb89a7T4re8cua4ov2kx55qjp3w1g479",
   [junit4]    >   "source":"node_added_trigger",
   [junit4]    >   "eventTime":3113427547163047,
   [junit4]    >   "eventType":"NODEADDED",
   [junit4]    >   "properties":{
   [junit4]    >     "eventTimes":[3113427547163047],
   [junit4]    >     "preferredOperation":"movereplica",
   [junit4]    >     "_enqueue_time_":3113431256431697,
   [junit4]    >     "nodeNames":["127.0.0.1:10458_solr"]}}, context={}, 
config={
   [junit4]    >   "trigger":"node_added_trigger",
   [junit4]    >   "stage":[
   [junit4]    >     "STARTED",
   [junit4]    >     "ABORTED",
   [junit4]    >     "SUCCEEDED",
   [junit4]    >     "FAILED"],
   [junit4]    >   "beforeAction":"test",
   [junit4]    >   "afterAction":[
   [junit4]    >     "test",
   [junit4]    >     "test1"],
   [junit4]    >   
"class":"org.apache.solr.cloud.autoscaling.sim.TestSimTriggerIntegration$TestTriggerListener"},
 message='null'}, CapturedEvent{timestamp=3113434415471197, 
stage=BEFORE_ACTION, actionName='test', event={
   [junit4]    >   "id":"b0fa556fb89a7T4re8cua4ov2kx55qjp3w1g479",
   [junit4]    >   "source":"node_added_trigger",
   [junit4]    >   "eventTime":3113427547163047,
   [junit4]    >   "eventType":"NODEADDED",
   [junit4]    >   "properties":{
   [junit4]    >     "eventTimes":[3113427547163047],
   [junit4]    >     "preferredOperation":"movereplica",
   [junit4]    >     "_enqueue_time_":3113431256431697,
   [junit4]    >     "nodeNames":["127.0.0.1:10458_solr"]}}, 
context={properties.BEFORE_ACTION=[test, test1], source=node_added_trigger}, 
config={
   [junit4]    >   "trigger":"node_added_trigger",
   [junit4]    >   "stage":[
   [junit4]    >     "STARTED",
   [junit4]    >     "ABORTED",
   [junit4]    >     "SUCCEEDED",
   [junit4]    >     "FAILED"],
   [junit4]    >   "beforeAction":"test",
   [junit4]    >   "afterAction":[
   [junit4]    >     "test",
   [junit4]    >     "test1"],
   [junit4]    >   
"class":"org.apache.solr.cloud.autoscaling.sim.TestSimTriggerIntegration$TestTriggerListener"},
 message='null'}, CapturedEvent{timestamp=3113434907535297, stage=AFTER_ACTION, 
actionName='test', event={
   [junit4]    >   "id":"b0fa556fb89a7T4re8cua4ov2kx55qjp3w1g479",
   [junit4]    >   "source":"node_added_trigger",
   [junit4]    >   "eventTime":3113427547163047,
   [junit4]    >   "eventType":"NODEADDED",
   [junit4]    >   "properties":{
   [junit4]    >     "eventTimes":[3113427547163047],
   [junit4]    >     "preferredOperation":"movereplica",
   [junit4]    >     "_enqueue_time_":3113431256431697,
   [junit4]    >     "nodeNames":["127.0.0.1:10458_solr"]}}, 
context={properties.BEFORE_ACTION=[test, test1], source=node_added_trigger, 
properties.AFTER_ACTION=[test, test1]}, config={
   [junit4]    >   "trigger":"node_added_trigger",
   [junit4]    >   "stage":[
   [junit4]    >     "STARTED",
   [junit4]    >     "ABORTED",
   [junit4]    >     "SUCCEEDED",
   [junit4]    >     "FAILED"],
   [junit4]    >   "beforeAction":"test",
   [junit4]    >   "afterAction":[
   [junit4]    >     "test",
   [junit4]    >     "test1"],
   [junit4]    >   
"class":"org.apache.solr.cloud.autoscaling.sim.TestSimTriggerIntegration$TestTriggerListener"},
 message='null'}, CapturedEvent{timestamp=3113434909202447, stage=AFTER_ACTION, 
actionName='test1', event={
   [junit4]    >   "id":"b0fa556fb89a7T4re8cua4ov2kx55qjp3w1g479",
   [junit4]    >   "source":"node_added_trigger",
   [junit4]    >   "eventTime":3113427547163047,
   [junit4]    >   "eventType":"NODEADDED",
   [junit4]    >   "properties":{
   [junit4]    >     "eventTimes":[3113427547163047],
   [junit4]    >     "preferredOperation":"movereplica",
   [junit4]    >     "_enqueue_time_":3113431256431697,
   [junit4]    >     "nodeNames":["127.0.0.1:10458_solr"]}}, 
context={properties.BEFORE_ACTION=[test, test1], source=node_added_trigger, 
properties.AFTER_ACTION=[test, test1]}, config={
   [junit4]    >   "trigger":"node_added_trigger",
   [junit4]    >   "stage":[
   [junit4]    >     "STARTED",
   [junit4]    >     "ABORTED",
   [junit4]    >     "SUCCEEDED",
   [junit4]    >     "FAILED"],
   [junit4]    >   "beforeAction":"test",
   [junit4]    >   "afterAction":[
   [junit4]    >     "test",
   [junit4]    >     "test1"],
   [junit4]    >   
"class":"org.apache.solr.cloud.autoscaling.sim.TestSimTriggerIntegration$TestTriggerListener"},
 message='null'}] expected:<5> but was:<4>
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([C5DF466912AB72C0:281FD179AFC7EF19]:0)
   [junit4]    >        at 
org.apache.solr.cloud.autoscaling.sim.TestSimTriggerIntegration.testListeners(TestSimTriggerIntegration.java:1015)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4] IGNOR/A 0.00s J0 | 
TestSimTriggerIntegration.testNodeMarkersRegistration
   [junit4]    > Assumption #1: 'badapple' test group is disabled 
(@BadApple(bugUrl=https://issues.apache.org/jira/browse/SOLR-12028))
   [junit4] IGNOR/A 0.00s J0 | TestSimTriggerIntegration.testNodeAddedTrigger
   [junit4]    > Assumption #1: 'badapple' test group is disabled 
(@BadApple(bugUrl=https://issues.apache.org/jira/browse/SOLR-12028))
   [junit4]   2> 2128053 DEBUG 
(TEST-TestSimTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[C5DF466912AB72C0])
 [    ] o.a.s.c.a.s.SimClusterStateProvider --- new Overseer leader: 
127.0.0.1:10459_solr
   [junit4]   2> 2128054 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and 
.scheduled_maintenance triggers
   [junit4]   2> 2128054 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode 
version 0
   [junit4]   2> 2128054 DEBUG 
(TEST-TestSimTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[C5DF466912AB72C0])
 [    ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=0
   [junit4]   2> 2128054 DEBUG 
(TEST-TestSimTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[C5DF466912AB72C0])
 [    ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 0
   [junit4]   2> 2128054 INFO  
(TEST-TestSimTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[C5DF466912AB72C0])
 [    ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics 
history in memory.
   [junit4]   2> 2128054 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion -1
   [junit4]   2> 2128054 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 0
   [junit4]   2> 2128054 INFO  (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial 
livenodes: [127.0.0.1:10459_solr, 127.0.0.1:10460_solr]
   [junit4]   2> 2128054 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 2128054 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion 0
   [junit4]   2> 2128055 DEBUG (ScheduledTrigger-13416-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 2128055 DEBUG (simCloudManagerPool-13415-thread-2) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 2128055 DEBUG (simCloudManagerPool-13415-thread-2) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
1
   [junit4]   2> 2128056 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
   [junit4]   2> 2128057 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 2128057 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 2128057 DEBUG (simCloudManagerPool-13415-thread-3) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 2128057 DEBUG (simCloudManagerPool-13415-thread-3) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
2
   [junit4]   2> 2128057 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
   [junit4]   2> 2128058 INFO  (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.s.TestSimTriggerIntegration TestTriggerAction init
   [junit4]   2> 2128058 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_restore_trigger - 
Initial livenodes: [127.0.0.1:10459_solr, 127.0.0.1:10460_solr]
   [junit4]   2> 2128058 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_restore_trigger 
instantiated with properties: {event=nodeAdded, waitFor=5, actions=[{name=test, 
class=org.apache.solr.cloud.autoscaling.sim.TestSimTriggerIntegration$TestTriggerAction}],
 enabled=true}
   [junit4]   2> 2128058 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
   [junit4]   2> 2128058 DEBUG (ScheduledTrigger-13416-thread-1) [    ] 
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_restore_trigger
   [junit4]   2> 2128058 DEBUG (ScheduledTrigger-13416-thread-1) [    ] 
o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
   [junit4]   2> 2128058 DEBUG (ScheduledTrigger-13416-thread-1) [    ] 
o.a.s.c.a.NodeAddedTrigger Tracking new node: 127.0.0.1:10461_solr at time 
3113440149286497
   [junit4]   2> 2128081 DEBUG (ScheduledTrigger-13416-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 3 and last live nodes: 2
   [junit4]   2> 2128082 DEBUG (ScheduledTrigger-13416-thread-2) [    ] 
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_restore_trigger
   [junit4]   2> 2128082 DEBUG (ScheduledTrigger-13416-thread-2) [    ] 
o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
   [junit4]   2> 2128091 DEBUG (simCloudManagerPool-13415-thread-4) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 2128092 DEBUG (simCloudManagerPool-13415-thread-4) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
3
   [junit4]   2> 2128092 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 3
   [junit4]   2> 2128092 INFO  (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.s.TestSimTriggerIntegration TestTriggerAction init
   [junit4]   2> 2128092 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_restore_trigger - 
Initial livenodes: [127.0.0.1:10459_solr, 127.0.0.1:10461_solr, 
127.0.0.1:10460_solr]
   [junit4]   2> 2128092 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_restore_trigger 
instantiated with properties: {event=nodeAdded, waitFor=0, actions=[{name=test, 
class=org.apache.solr.cloud.autoscaling.sim.TestSimTriggerIntegration$TestTriggerAction}],
 enabled=true}
   [junit4]   2> 2128092 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_restore_trigger - 
removing marker path: /autoscaling/nodeAdded/127.0.0.1:10461_solr
   [junit4]   2> 2128092 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion 3
   [junit4]   2> 2128092 DEBUG (ScheduledTrigger-13416-thread-1) [    ] 
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_restore_trigger
   [junit4]   2> 2128092 DEBUG (ScheduledTrigger-13416-thread-1) [    ] 
o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
   [junit4]   2> 2128092 DEBUG (ScheduledTrigger-13416-thread-1) [    ] 
o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_restore_trigger firing 
registered processor for nodes: [127.0.0.1:10461_solr] added at times 
[3113440149286497], now=3113441876341447
   [junit4]   2> 2128093 DEBUG (ScheduledTrigger-13416-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown inactive - processing event: {
   [junit4]   2>   "id":"b0fa84620ae61T4re8cua4ov2kx55qjp3w1g47d",
   [junit4]   2>   "source":"node_added_restore_trigger",
   [junit4]   2>   "eventTime":3113440149286497,
   [junit4]   2>   "eventType":"NODEADDED",
   [junit4]   2>   "properties":{
   [junit4]   2>     "eventTimes":[3113440149286497],
   [junit4]   2>     "preferredOperation":"movereplica",
   [junit4]   2>     "nodeNames":["127.0.0.1:10461_solr"]}}
   [junit4]   2> 2128097 DEBUG (ScheduledTrigger-13416-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers Pausing all triggers: [.auto_add_replicas, 
node_added_restore_trigger]
   [junit4]   2> 2128101 DEBUG (simCloudManagerPool-13415-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- simCreateCollection .system, 
currentVersion=1
   [junit4]   2> 2128101 DEBUG (simCloudManagerPool-13415-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=1
   [junit4]   2> 2128101 DEBUG (simCloudManagerPool-13415-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 1
   [junit4]   2> 2128112 DEBUG (simCloudManagerPool-13415-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=2
   [junit4]   2> 2128112 DEBUG (simCloudManagerPool-13415-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 2
   [junit4]   2> 2128131 DEBUG (simCloudManagerPool-13415-thread-7) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=3
   [junit4]   2> 2128131 DEBUG (simCloudManagerPool-13415-thread-7) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 3
   [junit4]   2> 2128145 DEBUG (simCloudManagerPool-13415-thread-6) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=4
   [junit4]   2> 2128145 DEBUG (simCloudManagerPool-13415-thread-6) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 4
   [junit4]   2> 2128156 DEBUG (simCloudManagerPool-13415-thread-8) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=5
   [junit4]   2> 2128156 DEBUG (simCloudManagerPool-13415-thread-8) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 5
   [junit4]   2> 2128156 DEBUG (simCloudManagerPool-13415-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- finished createCollection .system, 
currentVersion=6
   [junit4]   2> 2128156 INFO  (simCloudManagerPool-13415-thread-5) [    ] 
o.a.s.c.CloudTestUtils -- shards without leaders: [shard1]
   [junit4]   2> 2128157 DEBUG (simCloudManagerPool-13415-thread-11) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for .system / shard1 
(currentVersion=6): {"core_node1":{
   [junit4]   2>     "core":".system_shard1_replica_n1",
   [junit4]   2>     "shard":"shard1",
   [junit4]   2>     "collection":".system",
   [junit4]   2>     "node_name":"127.0.0.1:10460_solr",
   [junit4]   2>     "type":"NRT",
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>     "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>     "INDEX.sizeInBytes":10240,
   [junit4]   2>     "state":"active",
   [junit4]   2>     "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>     "SEARCHER.searcher.numDocs":0}}
   [junit4]   2> 2128162 INFO  (simCloudManagerPool-13415-thread-9) [    ] 
o.a.s.c.ActionThrottle Throttling leader attempts - waiting for 4709ms
   [junit4]   2> 2128258 DEBUG (simCloudManagerPool-13415-thread-9) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for .system / shard1 
(currentVersion=6): {"core_node2":{
   [junit4]   2>     "core":".system_shard1_replica_n2",
   [junit4]   2>     "shard":"shard1",
   [junit4]   2>     "collection":".system",
   [junit4]   2>     "node_name":"127.0.0.1:10461_solr",
   [junit4]   2>     "type":"NRT",
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>     "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>     "INDEX.sizeInBytes":10240,
   [junit4]   2>     "state":"active",
   [junit4]   2>     "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>     "SEARCHER.searcher.numDocs":0}}
   [junit4]   2> 2128258 DEBUG (simCloudManagerPool-13415-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=6
   [junit4]   2> 2128258 DEBUG (simCloudManagerPool-13415-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 6
   [junit4]   2> 2128258 DEBUG (ScheduledTrigger-13416-thread-1) [    ] 
o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_restore_trigger - 
removing marker path: /autoscaling/nodeAdded/127.0.0.1:10461_solr
   [junit4]   2> 2128259 DEBUG (AutoscalingActionExecutor-13417-thread-1) [    
] o.a.s.c.a.ScheduledTriggers -- processing actions for {
   [junit4]   2>   "id":"b0fa84620ae61T4re8cua4ov2kx55qjp3w1g47d",
   [junit4]   2>   "source":"node_added_restore_trigger",
   [junit4]   2>   "eventTime":3113440149286497,
   [junit4]   2>   "eventType":"NODEADDED",
   [junit4]   2>   "properties":{
   [junit4]   2>     "eventTimes":[3113440149286497],
   [junit4]   2>     "preferredOperation":"movereplica",
   [junit4]   2>     "_enqueue_time_":3113442115026497,
   [junit4]   2>     "nodeNames":["127.0.0.1:10461_solr"]}}
   [junit4]   2> 2128260 INFO  (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are 
closed, exiting.
   [junit4]   2> 2128261 DEBUG 
(TEST-TestSimTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[C5DF466912AB72C0])
 [    ] o.a.s.c.a.ScheduledTriggers Shutting down scheduled thread pool 
executor now
   [junit4]   2> 2128261 DEBUG 
(TEST-TestSimTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[C5DF466912AB72C0])
 [    ] o.a.s.c.a.ScheduledTriggers Shutting down action executor now
   [junit4]   2> 2128261 DEBUG 
(TEST-TestSimTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[C5DF466912AB72C0])
 [    ] o.a.s.c.a.ScheduledTriggers Awaiting termination for action executor
   [junit4]   2> 2128261 WARN  (AutoscalingActionExecutor-13417-thread-1) [    
] o.a.s.c.a.SystemLogListener Exception sending event to collection .system
   [junit4]   2> java.io.IOException: java.lang.InterruptedException
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.sim.SimCloudManager.request(SimCloudManager.java:654)
 ~[test/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.SystemLogListener.onEvent(SystemLogListener.java:118)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:801)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:768)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$null$3(ScheduledTriggers.java:321)
 ~[java/:?]
   [junit4]   2>        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) 
~[?:1.8.0_191]
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[?:1.8.0_191]
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
 ~[java/:?]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) 
[?:1.8.0_191]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) 
[?:1.8.0_191]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_191]
   [junit4]   2> Caused by: java.lang.InterruptedException
   [junit4]   2>        at 
java.util.concurrent.FutureTask.awaitDone(FutureTask.java:404) ~[?:1.8.0_191]
   [junit4]   2>        at 
java.util.concurrent.FutureTask.get(FutureTask.java:191) ~[?:1.8.0_191]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.sim.SimCloudManager.request(SimCloudManager.java:652)
 ~[test/:?]
   [junit4]   2>        ... 10 more
   [junit4]   2> 2128261 DEBUG (AutoscalingActionExecutor-13417-thread-1) [    
] o.a.s.c.a.ScheduledTriggers -- processing took 95 ms for event 
id=b0fa84620ae61T4re8cua4ov2kx55qjp3w1g47d
   [junit4]   2> 2128261 DEBUG 
(TEST-TestSimTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[C5DF466912AB72C0])
 [    ] o.a.s.c.a.ScheduledTriggers Awaiting termination for scheduled thread 
pool executor
   [junit4]   2> 2128261 DEBUG 
(TEST-TestSimTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[C5DF466912AB72C0])
 [    ] o.a.s.c.a.ScheduledTriggers ScheduledTriggers closed completely
   [junit4]   2> 2128261 DEBUG 
(TEST-TestSimTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[C5DF466912AB72C0])
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed 
explicitly
   [junit4] IGNOR/A 0.00s J0 | TestSimTriggerIntegration.testCooldown
   [junit4]    > Assumption #1: 'badapple' test group is disabled 
(@BadApple(bugUrl=https://issues.apache.org/jira/browse/SOLR-12028))
   [junit4] IGNOR/A 0.00s J0 | TestSimTriggerIntegration.testSearchRate
   [junit4]    > Assumption #1: 'awaitsfix' test group is disabled 
(@AwaitsFix(bugUrl=https://issues.apache.org/jira/browse/SOLR-12028))
   [junit4]   2> 2128291 DEBUG 
(TEST-TestSimTriggerIntegration.testNodeLostTriggerRestoreState-seed#[C5DF466912AB72C0])
 [    ] o.a.s.c.a.s.SimClusterStateProvider --- new Overseer leader: 
127.0.0.1:10462_solr
   [junit4]   2> 2128291 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and 
.scheduled_maintenance triggers
   [junit4]   2> 2128291 DEBUG 
(TEST-TestSimTriggerIntegration.testNodeLostTriggerRestoreState-seed#[C5DF466912AB72C0])
 [    ] o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=0
   [junit4]   2> 2128291 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode 
version 0
   [junit4]   2> 2128291 DEBUG 
(TEST-TestSimTriggerIntegration.testNodeLostTriggerRestoreState-seed#[C5DF466912AB72C0])
 [    ] o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 0
   [junit4]   2> 2128291 INFO  
(TEST-TestSimTriggerIntegration.testNodeLostTriggerRestoreState-seed#[C5DF466912AB72C0])
 [    ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics 
history in memory.
   [junit4]   2> 2128292 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion -1
   [junit4]   2> 2128292 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 0
   [junit4]   2> 2128292 INFO  (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial 
livenodes: [127.0.0.1:10462_solr, 127.0.0.1:10463_solr]
   [junit4]   2> 2128292 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 2128292 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion 0
   [junit4]   2> 2128292 DEBUG (ScheduledTrigger-13422-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 2128292 DEBUG (simCloudManagerPool-13421-thread-2) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 2128292 DEBUG (simCloudManagerPool-13421-thread-2) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
1
   [junit4]   2> 2128297 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
   [junit4]   2> 2128298 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 2128298 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 2128298 DEBUG (simCloudManagerPool-13421-thread-3) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 2128298 DEBUG (simCloudManagerPool-13421-thread-3) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
2
   [junit4]   2> 2128298 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
   [junit4]   2> 2128299 INFO  (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.s.TestSimTriggerIntegration TestTriggerAction init
   [junit4]   2> 2128299 INFO  (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger node_lost_restore_trigger - 
Initial livenodes: [127.0.0.1:10462_solr, 127.0.0.1:10463_solr]
   [junit4]   2> 2128299 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeLostTrigger Adding lost node from marker path: 
127.0.0.1:10464_solr
   [junit4]   2> 2128299 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 2128299 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
   [junit4]   2> 2128299 DEBUG (ScheduledTrigger-13422-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: node_lost_restore_trigger 
with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 2128317 DEBUG (ScheduledTrigger-13422-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 2128325 DEBUG (ScheduledTrigger-13422-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: node_lost_restore_trigger 
with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 2128331 DEBUG (simCloudManagerPool-13421-thread-4) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 2128331 DEBUG (simCloudManagerPool-13421-thread-4) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
3
   [junit4]   2> 2128331 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 3
   [junit4]   2> 2128332 INFO  (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.s.TestSimTriggerIntegration TestTriggerAction init
   [junit4]   2> 2128332 INFO  (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger node_lost_restore_trigger - 
Initial livenodes: [127.0.0.1:10462_solr, 127.0.0.1:10463_solr]
   [junit4]   2> 2128332 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 2128332 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion 3
   [junit4]   2> 2128332 DEBUG (ScheduledTrigger-13422-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: node_lost_restore_trigger 
with currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 2128332 DEBUG (ScheduledTrigger-13422-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger NodeLostTrigger firing registered processor for lost 
nodes: [127.0.0.1:10464_solr]
   [junit4]   2> 2128332 DEBUG (ScheduledTrigger-13422-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown inactive - processing event: {
   [junit4]   2>   "id":"b0fab1430c307T4re8cua4ov2kx55qjp3w1g47h",
   [junit4]   2>   "source":"node_lost_restore_trigger",
   [junit4]   2>   "eventTime":3113452196381447,
   [junit4]   2>   "eventType":"NODELOST",
   [junit4]   2>   "properties":{
   [junit4]   2>     "eventTimes":[3113452196381447],
   [junit4]   2>     "preferredOperation":"movereplica",
   [junit4]   2>     "nodeNames":["127.0.0.1:10464_solr"]}}
   [junit4]   2> 2128332 DEBUG (ScheduledTrigger-13422-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers Pausing all triggers: [.auto_add_replicas, 
node_lost_restore_trigger]
   [junit4]   2> 2128337 DEBUG (simCloudManagerPool-13421-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- simCreateCollection .system, 
currentVersion=1
   [junit4]   2> 2128338 DEBUG (simCloudManagerPool-13421-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=1
   [junit4]   2> 2128338 DEBUG (simCloudManagerPool-13421-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 1
   [junit4]   2> 2128349 DEBUG (simCloudManagerPool-13421-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=2
   [junit4]   2> 2128349 DEBUG (simCloudManagerPool-13421-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 2
   [junit4]   2> 2128360 DEBUG (simCloudManagerPool-13421-thread-6) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=3
   [junit4]   2> 2128361 DEBUG (simCloudManagerPool-13421-thread-6) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 3
   [junit4]   2> 2128361 DEBUG (simCloudManagerPool-13421-thread-8) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for .system / shard1 
(currentVersion=4): {"core_node1":{
   [junit4]   2>     "core":".system_shard1_replica_n1",
   [junit4]   2>     "shard":"shard1",
   [junit4]   2>     "collection":".system",
   [junit4]   2>     "node_name":"127.0.0.1:10463_solr",
   [junit4]   2>     "type":"NRT",
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>     "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>     "INDEX.sizeInBytes":10240,
   [junit4]   2>     "state":"active",
   [junit4]   2>     "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>     "SEARCHER.searcher.numDocs":0}}
   [junit4]   2> 2128372 DEBUG (simCloudManagerPool-13421-thread-7) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=4
   [junit4]   2> 2128372 DEBUG (simCloudManagerPool-13421-thread-7) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 4
   [junit4]   2> 2128372 DEBUG (simCloudManagerPool-13421-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- finished createCollection .system, 
currentVersion=5
   [junit4]   2> 2128373 DEBUG (AutoscalingActionExecutor-13423-thread-1) [    
] o.a.s.c.a.ScheduledTriggers -- processing actions for {
   [junit4]   2>   "id":"b0fab1430c307T4re8cua4ov2kx55qjp3w1g47h",
   [junit4]   2>   "source":"node_lost_restore_trigger",
   [junit4]   2>   "eventTime":3113452196381447,
   [junit4]   2>   "eventType":"NODELOST",
   [junit4]   2>   "properties":{
   [junit4]   2>     "eventTimes":[3113452196381447],
   [junit4]   2>     "preferredOperation":"movereplica",
   [junit4]   2>     "_enqueue_time_":3113453877542697,
   [junit4]   2>     "nodeNames":["127.0.0.1:10464_solr"]}}
   [junit4]   2> 2128374 INFO  (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are 
closed, exiting.
   [junit4]   2> 2128374 DEBUG 
(TEST-TestSimTriggerIntegration.testNodeLostTriggerRestoreState-seed#[C5DF466912AB72C0])
 [    ] o.a.s.c.a.ScheduledTriggers Shutting down scheduled thread pool 
executor now
   [junit4]   2> 2128375 DEBUG 
(TEST-TestSimTriggerIntegration.testNodeLostTriggerRestoreState-seed#[C5DF466912AB72C0])
 [    ] o.a.s.c.a.ScheduledTriggers Shutting down action executor now
   [junit4]   2> 2128375 DEBUG 
(TEST-TestSimTriggerIntegration.testNodeLostTriggerRestoreState-seed#[C5DF466912AB72C0])
 [    ] o.a.s.c.a.ScheduledTriggers Awaiting termination for action executor
   [junit4]   2> 2128374 WARN  (AutoscalingActionExecutor-13423-thread-1) [    
] o.a.s.c.a.SystemLogListener Exception sending event to collection .system
   [junit4]   2> java.io.IOException: java.util.concurrent.ExecutionException: 
java.io.IOException: already closed
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.sim.SimCloudManager.request(SimCloudManager.java:654)
 ~[test/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.SystemLogListener.onEvent(SystemLogListener.java:118)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:801)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerListeners.fireListeners(ScheduledTriggers.java:768)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$null$3(ScheduledTriggers.java:321)
 ~[java/:?]
   [junit4]   2>        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) 
~[?:1.8.0_191]
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[?:1.8.0_191]
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
 ~[java/:?]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) 
[?:1.8.0_191]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) 
[?:1.8.0_191]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_191]
   [junit4]   2> Caused by: java.util.concurrent.ExecutionException: 
java.io.IOException: already closed
   [junit4]   2>        at 
java.util.concurrent.FutureTask.report(FutureTask.java:122) ~[?:1.8.0_191]
   [junit4]   2>        at 
java.util.concurrent.FutureTask.get(FutureTask.java:192) ~[?:1.8.0_191]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.sim.SimCloudManager.request(SimCloudManager.java:652)
 ~[test/:?]
   [junit4]   2>        ... 10 more
   [junit4]   2> Caused by: java.io.IOException: already closed
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.sim.SimClusterStateProvider.ensureNotClosed(SimClusterStateProvider.java:2201)
 ~[test/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.sim.SimClusterStateProvider.simUpdate(SimClusterStateProvider.java:1418)
 ~[test/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.sim.SimCloudManager.simHandleSolrRequest(SimCloudManager.java:741)
 ~[test/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.sim.SimCloudManager.lambda$request$15(SimCloudManager.java:651)
 ~[test/:?]
   [junit4]   2>        ... 5 more
   [junit4]   2> 2128376 DEBUG (AutoscalingActionExecutor-13423-thread-1) [    
] o.a.s.c.a.ScheduledTriggers -- processing took 172 ms for event 
id=b0fab1430c307T4re8cua4ov2kx55qjp3w1g47h
   [junit4]   2> 2128381 DEBUG 
(TEST-TestSimTriggerIntegration.testNodeLostTriggerRestoreState-seed#[C5DF466912AB72C0])
 [    ] o.a.s.c.a.ScheduledTriggers Awaiting termination for scheduled thread 
pool executor
   [junit4]   2> 2128381 DEBUG 
(TEST-TestSimTriggerIntegration.testNodeLostTriggerRestoreState-seed#[C5DF466912AB72C0])
 [    ] o.a.s.c.a.ScheduledTriggers ScheduledTriggers closed completely
   [junit4]   2> 2128381 DEBUG 
(TEST-TestSimTriggerIntegration.testNodeLostTriggerRestoreState-seed#[C5DF466912AB72C0])
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed 
explicitly
   [junit4] IGNOR/A 0.00s J0 | 
TestSimTriggerIntegration.testEventFromRestoredState
   [junit4]    > Assumption #1: 'badapple' test group is disabled 
(@BadApple(bugUrl=https://issues.apache.org/jira/browse/SOLR-12028))
   [junit4] IGNOR/A 0.00s J0 | TestSimTriggerIntegration.testEventQueue
   [junit4]    > Assumption #1: 'awaitsfix' test group is disabled 
(@AwaitsFix(bugUrl=https://issues.apache.org/jira/browse/SOLR-12028))
   [junit4] IGNOR/A 0.00s J0 | TestSimTriggerIntegration.testTriggerThrottling
   [junit4]    > Assumption #1: 'badapple' test group is disabled 
(@BadApple(bugUrl=https://issues.apache.org/jira/browse/SOLR-12028))
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.sim.TestSimTriggerIntegration_C5DF466912AB72C0-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene80): {}, 
docValues:{}, maxPointsInLeafNode=1414, maxMBSortInHeap=6.535328187212216, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@7f229e1f),
 locale=ar-SY, timezone=Antarctica/Troll
   [junit4]   2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_191 
(64-bit)/cpus=3,threads=1,free=122914664,total=530579456
   [junit4]   2> NOTE: All tests run in this JVM: [LegacyCloudClusterPropTest, 
TestCollectionAPIs, QueryResultKeyTest, TestDocBasedVersionConstraints, 
TestTrieFacet, SoftAutoCommitTest, TestRestoreCore, BlockJoinFacetDistribTest, 
DistributedFacetPivotSmallAdvancedTest, CollectionPropsTest, 
IgnoreLargeDocumentProcessorFactoryTest, TransactionLogTest, TestHdfsUpdateLog, 
TemplateUpdateProcessorTest, TestCSVResponseWriter, ConnectionReuseTest, 
SolrIndexConfigTest, SolrGraphiteReporterTest, 
DistributedFacetSimpleRefinementLongTailTest, TestDynamicLoading, 
PreAnalyzedFieldManagedSchemaCloudTest, TestNumericTerms32, 
ReplicaListTransformerTest, TestHdfsBackupRestoreCore, 
SuggestComponentContextFilterQueryTest, JsonLoaderTest, 
BinaryUpdateRequestHandlerTest, AtomicUpdatesTest, ClusterStateTest, 
SolrCloudExampleTest, TestFieldResource, TestReversedWildcardFilterFactory, 
HdfsNNFailoverTest, AutoAddReplicasIntegrationTest, ZkStateWriterTest, 
TestCoreDiscovery, MergeStrategyTest, TestNestedUpdateProcessor, 
PingRequestHandlerTest, AssignBackwardCompatibilityTest, 
CollectionsAPISolrJTest, TestSimDistributedQueue, 
TestLegacyNumericRangeQueryBuilder, ShowFileRequestHandlerTest, 
TestCrossCoreJoin, TestStressVersions, ShardRoutingTest, 
OverseerCollectionConfigSetProcessorTest, TestLRUStatsCache, HttpPartitionTest, 
IndexSchemaTest, PhrasesIdentificationComponentTest, ExternalFileFieldSortTest, 
TestMultiWordSynonyms, DataDrivenBlockJoinTest, PeerSyncWithLeaderTest, 
TestExportWriter, ChaosMonkeyNothingIsSafeWithPullReplicasTest, 
TestManagedSchemaThreadSafety, TestJavabinTupleStreamParser, 
TestMinHashQParser, UUIDUpdateProcessorFallbackTest, TestPivotHelperCode, 
CollectionTooManyReplicasTest, BasicZkTest, SolrMetricManagerTest, 
PeerSyncWithIndexFingerprintCachingTest, CloneFieldUpdateProcessorFactoryTest, 
DistributedExpandComponentTest, TestSearchPerf, PeerSyncTest, 
BasicAuthStandaloneTest, TestDistributedSearch, AssignTest, OutputWriterTest, 
MoveReplicaTest, TestPointFields, TestStressReorder, EchoParamsTest, 
TestOrdValues, TestSweetSpotSimilarityFactory, CoreAdminCreateDiscoverTest, 
TestSolrCloudWithSecureImpersonation, TestWriterPerf, TestManagedSchema, 
AnalysisAfterCoreReloadTest, LoggingHandlerTest, TestTlogReplica, 
SliceStateTest, TlogReplayBufferedWhileIndexingTest, MigrateRouteKeyTest, 
BigEndianAscendingWordSerializerTest, ScheduledTriggerTest, TestSchemaResource, 
TestFieldTypeResource, TestPayloadScoreQParserPlugin, SparseHLLTest, 
MBeansHandlerTest, NodeAddedTriggerIntegrationTest, CoreSorterTest, 
ProtectedTermFilterFactoryTest, BlockCacheTest, TestTrie, 
XmlUpdateRequestHandlerTest, TestAuthorizationFramework, TestNRTOpen, 
TestSolrCloudWithDelegationTokens, UpdateRequestProcessorFactoryTest, 
UpdateParamsTest, TestDeprecatedFilters, SpatialHeatmapFacetsTest, 
TestClassicSimilarityFactory, TestCloudPseudoReturnFields, 
ClassificationUpdateProcessorIntegrationTest, TestSolrConfigHandlerConcurrent, 
HttpSolrCallGetCoreTest, TestQueryTypes, DistributedVersionInfoTest, 
TestConfigSetsAPIExclusivity, TestEmbeddedSolrServerSchemaAPI, 
TestClusterProperties, TestDistribDocBasedVersion, TestCustomStream, 
SuggesterFSTTest, TestMultiValuedNumericRangeQuery, CustomCollectionTest, 
TestSimNodeLostTrigger, TestStressLucene, TestDefaultStatsCache, 
PrimitiveFieldTypeTest, TestLazyCores, TriggerSetPropertiesIntegrationTest, 
DistributedSuggestComponentTest, HealthCheckHandlerTest, 
TestSimpleQParserPlugin, TestManagedSynonymFilterFactory, BadCopyFieldTest, 
TestClusterStateMutator, OverseerTaskQueueTest, 
OpenExchangeRatesOrgProviderTest, ExplicitHLLTest, TestReload, 
TestManagedResource, SearchRateTriggerTest, TestCoreAdminApis, 
TestHighFrequencyDictionaryFactory, TestFieldCacheSortRandom, 
HttpTriggerListenerTest, TestAuthenticationFramework, TestLegacyField, 
TestLegacyNumericUtils, TestRawTransformer, SolrInfoBeanTest, 
AutoScalingHandlerTest, CleanupOldIndexTest, DateFieldTest, HdfsRecoveryZkTest, 
DocValuesMissingTest, ScriptEngineTest, TestConfigSets, NumberUtilsTest, 
TestInPlaceUpdatesStandalone, TestXmlQParser, TestDocTermOrdsUninvertLimit, 
TestExtendedDismaxParser, ScheduledMaintenanceTriggerTest, 
SynonymTokenizerTest, AnalyticsQueryTest, ConfigSetsAPITest, TestSolrJ, 
TestLegacyBM25SimilarityFactory, TestGeoJSONResponseWriter, TestLFUCache, 
BadComponentTest, RuleEngineTest, DisMaxRequestHandlerTest, 
TestFreeTextSuggestions, TestCopyFieldCollectionResource, QueryParsingTest, 
SpellPossibilityIteratorTest, TestGraphTermsQParserPlugin, 
DistributedFacetPivotLargeTest, CdcrOpsAndBoundariesTest, 
ReplaceNodeNoTargetTest, TestCloudNestedDocsSort, TestRequestForwarding, 
DistributedQueryComponentCustomSortTest, 
DistributedQueryElevationComponentTest, TestIndexSearcher, DeleteShardTest, 
TestSimComputePlanAction, MetricsHistoryHandlerTest, TestMaxTokenLenTokenizer, 
TestInitParams, TestSolrXml, Tagger2Test, TestDFRSimilarityFactory, 
TestQuerySenderNoQuery, TestSchemalessBufferedUpdates, 
TestImplicitCoreProperties, ZkFailoverTest, HLLSerializationTest, 
SimpleFacetsTest, DistribJoinFromCollectionTest, DistributedQueueTest, 
ForceLeaderTest, FullSolrCloudDistribCmdsTest, LeaderElectionTest, 
LeaderFailoverAfterPartitionTest, LeaderFailureAfterFreshStartTest, 
LeaderVoteWaitTimeoutTest, NodeMutatorTest, 
OutOfBoxZkACLAndCredentialsProvidersTest, 
OverriddenZkACLAndCredentialsProvidersTest, OverseerRolesTest, 
OverseerStatusTest, PeerSyncReplicationTest, SSLMigrationTest, 
SaslZkACLProviderTest, ShardRoutingCustomTest, SplitShardTest, 
TestCloudDeleteByQuery, TestCloudInspectUtil, 
TestCloudPhrasesIdentificationComponent, TestCloudPivotFacet, 
TestCloudRecovery2, TestCryptoKeys, TestDeleteCollectionOnDownNodes, 
TestDownShardTolerantSearch, TestExclusionRuleCollectionAccess, 
TestHashPartitioner, TestLeaderElectionZkExpiry, TestLockTree, 
TestMiniSolrCloudClusterSSL, TestPullReplica, TestPullReplicaErrorHandling, 
TestRandomRequestDistribution, TestSegmentSorting, TestShortCircuitedRequests, 
TestSizeLimitedDistributedMap, TestSkipOverseerOperations, 
TestStressInPlaceUpdates, TestStressLiveNodes, 
TestTolerantUpdateProcessorRandomCloud, TestWithCollection, ZkSolrClientTest, 
ConcurrentDeleteAndCreateCollectionTest, ShardSplitTest, 
TestRequestStatusCollectionAPI, HdfsAutoAddReplicasIntegrationTest, 
MetricTriggerIntegrationTest, MetricTriggerTest, NodeLostTriggerTest, 
TestPolicyCloud, TestSimExtremeIndexing, TestSimGenericDistributedQueue, 
TestSimLargeCluster, TestSimNodeAddedTrigger, TestSimTriggerIntegration]
   [junit4] Completed [544/838 (1!)] on J0 in 0.77s, 11 tests, 1 failure, 8 
skipped <<< FAILURES!

[...truncated 2144 lines...]
   [junit4] Suite: org.apache.solr.client.solrj.io.stream.StreamDecoratorTest
   [junit4]   2> 312894 INFO  
(SUITE-StreamDecoratorTest-seed#[83A76DFB87A23EC0]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamDecoratorTest_83A76DFB87A23EC0-001/init-core-data-001
   [junit4]   2> 312898 WARN  
(SUITE-StreamDecoratorTest-seed#[83A76DFB87A23EC0]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=3 numCloses=3
   [junit4]   2> 312898 INFO  
(SUITE-StreamDecoratorTest-seed#[83A76DFB87A23EC0]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 312899 INFO  
(SUITE-StreamDecoratorTest-seed#[83A76DFB87A23EC0]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None)
   [junit4]   2> 312900 INFO  
(SUITE-StreamDecoratorTest-seed#[83A76DFB87A23EC0]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamDecoratorTest_83A76DFB87A23EC0-001/tempDir-001
   [junit4]   2> 312900 INFO  
(SUITE-StreamDecoratorTest-seed#[83A76DFB87A23EC0]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 312900 INFO  (ZkTestServer Run Thread) [    ] 
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 312900 INFO  (ZkTestServer Run Thread) [    ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 313001 INFO  
(SUITE-StreamDecoratorTest-seed#[83A76DFB87A23EC0]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:64778
   [junit4]   2> 313001 INFO  
(SUITE-StreamDecoratorTest-seed#[83A76DFB87A23EC0]-worker) [    ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:64778
   [junit4]   2> 313001 INFO  
(SUITE-StreamDecoratorTest-seed#[83A76DFB87A23EC0]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 64778
   [junit4]   2> 313006 INFO  (zkConnectionManagerCallback-2086-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 313011 INFO  (zkConnectionManagerCallback-2088-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 313014 INFO  (zkConnectionManagerCallback-2090-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 313017 WARN  (jetty-launcher-2091-thread-1) [    ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 313017 INFO  (jetty-launcher-2091-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 313017 INFO  (jetty-launcher-2091-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 313017 INFO  (jetty-launcher-2091-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: 
c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
   [junit4]   2> 313018 INFO  (jetty-launcher-2091-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 313018 INFO  (jetty-launcher-2091-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 313018 INFO  (jetty-launcher-2091-thread-1) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 313019 WARN  (jetty-launcher-2091-thread-2) [    ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 313019 INFO  (jetty-launcher-2091-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 313020 INFO  (jetty-launcher-2091-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 313020 INFO  (jetty-launcher-2091-thread-2) [    ] 
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: 
c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
   [junit4]   2> 313021 WARN  (jetty-launcher-2091-thread-4) [    ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 313020 INFO  (jetty-launcher-2091-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@46f996ba{/solr,null,AVAILABLE}
   [junit4]   2> 313021 INFO  (jetty-launcher-2091-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 313021 INFO  (jetty-launcher-2091-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 313021 INFO  (jetty-launcher-2091-thread-4) [    ] 
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: 
c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
   [junit4]   2> 313022 WARN  (jetty-launcher-2091-thread-3) [    ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 313022 INFO  (jetty-launcher-2091-thread-2) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 313022 INFO  (jetty-launcher-2091-thread-2) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 313022 INFO  (jetty-launcher-2091-thread-2) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 313023 INFO  (jetty-launcher-2091-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@400a28b8{/solr,null,AVAILABLE}
   [junit4]   2> 313023 INFO  (jetty-launcher-2091-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 313023 INFO  (jetty-launcher-2091-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 313023 INFO  (jetty-launcher-2091-thread-3) [    ] 
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: 
c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
   [junit4]   2> 313024 INFO  (jetty-launcher-2091-thread-3) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 313024 INFO  (jetty-launcher-2091-thread-3) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 313024 INFO  (jetty-launcher-2091-thread-3) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 313024 INFO  (jetty-launcher-2091-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@85a4c1b{/solr,null,AVAILABLE}
   [junit4]   2> 313026 INFO  (jetty-launcher-2091-thread-2) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@2375e6b3{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:48234}
   [junit4]   2> 313026 INFO  (jetty-launcher-2091-thread-2) [    ] 
o.e.j.s.Server Started @313257ms
   [junit4]   2> 313026 INFO  (jetty-launcher-2091-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=48234}
   [junit4]   2> 313026 ERROR (jetty-launcher-2091-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 313026 INFO  (jetty-launcher-2091-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 313026 INFO  (jetty-launcher-2091-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 313026 INFO  (jetty-launcher-2091-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 313026 INFO  (jetty-launcher-2091-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 313026 INFO  (jetty-launcher-2091-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-12-19T20:51:03.916Z
   [junit4]   2> 313026 INFO  (jetty-launcher-2091-thread-3) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@21f5e69a{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:43716}
   [junit4]   2> 313027 INFO  (jetty-launcher-2091-thread-3) [    ] 
o.e.j.s.Server Started @313258ms
   [junit4]   2> 313027 INFO  (jetty-launcher-2091-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=43716}
   [junit4]   2> 313028 INFO  (jetty-launcher-2091-thread-4) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 313028 INFO  (jetty-launcher-2091-thread-4) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 313028 INFO  (jetty-launcher-2091-thread-4) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 313029 INFO  (jetty-launcher-2091-thread-4) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@595ba041{/solr,null,AVAILABLE}
   [junit4]   2> 313028 ERROR (jetty-launcher-2091-thread-3) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 313029 INFO  (jetty-launcher-2091-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 313029 INFO  (jetty-launcher-2091-thread-4) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@5041cde5{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:51439}
   [junit4]   2> 313030 INFO  (jetty-launcher-2091-thread-4) [    ] 
o.e.j.s.Server Started @313261ms
   [junit4]   2> 313030 INFO  (jetty-launcher-2091-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 313030 INFO  (jetty-launcher-2091-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=51439}
   [junit4]   2> 313030 INFO  (jetty-launcher-2091-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 313030 INFO  (jetty-launcher-2091-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 313030 INFO  (jetty-launcher-2091-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-12-19T20:51:03.920Z
   [junit4]   2> 313030 INFO  (jetty-launcher-2091-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@2161179d{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:50398}
   [junit4]   2> 313030 INFO  (jetty-launcher-2091-thread-1) [    ] 
o.e.j.s.Server Started @313262ms
   [junit4]   2> 313030 INFO  (jetty-launcher-2091-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=50398}
   [junit4]   2> 313033 ERROR (jetty-launcher-2091-thread-4) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 313033 INFO  (jetty-launcher-2091-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 313033 INFO  (jetty-launcher-2091-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 313033 INFO  (jetty-launcher-2091-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 313033 INFO  (jetty-launcher-2091-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 313033 INFO  (jetty-launcher-2091-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-12-19T20:51:03.923Z
   [junit4]   2> 313037 ERROR (jetty-launcher-2091-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 313037 INFO  (jetty-launcher-2091-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 313037 INFO  (jetty-launcher-2091-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 313037 INFO  (jetty-launcher-2091-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 313037 INFO  (jetty-launcher-2091-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 313037 INFO  (jetty-launcher-2091-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-12-19T20:51:03.927Z
   [junit4]   2> 313038 INFO  (zkConnectionManagerCallback-2093-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 313039 INFO  (zkConnectionManagerCallback-2095-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 313039 INFO  (zkConnectionManagerCallback-2097-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 313040 INFO  (jetty-launcher-2091-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4] 

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

] on J0 in 88.71s, 47 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.io.stream.StreamDecoratorTest
   [junit4] OK      0.14s J1 | StreamDecoratorTest.testInnerJoinStream
   [junit4] OK      0.13s J1 | StreamDecoratorTest.testSortStream
   [junit4] OK      0.11s J1 | StreamDecoratorTest.testComplementStream
   [junit4] OK      10.1s J1 | StreamDecoratorTest.testParallelExecutorStream
   [junit4] OK      0.11s J1 | StreamDecoratorTest.testNullStream
   [junit4] OK      0.16s J1 | StreamDecoratorTest.testParallelPriorityStream
   [junit4] OK      0.12s J1 | StreamDecoratorTest.testParallelShuffleStream
   [junit4] OK      0.12s J1 | StreamDecoratorTest.testSelectStream
   [junit4] OK      0.13s J1 | StreamDecoratorTest.testParallelRankStream
   [junit4] OK      0.11s J1 | StreamDecoratorTest.testParallelNullStream
   [junit4] OK      0.15s J1 | StreamDecoratorTest.testParallelFetchStream
   [junit4] OK      0.12s J1 | 
StreamDecoratorTest.testOuterHashJoinStreamWithKnownConflict
   [junit4] OK      0.12s J1 | StreamDecoratorTest.testRollupStream
   [junit4] OK      0.11s J1 | StreamDecoratorTest.testStream
   [junit4] OK      4.17s J1 | 
StreamDecoratorTest.testParallelDaemonUpdateStream
   [junit4] OK      0.12s J1 | StreamDecoratorTest.testParallelIntersectStream
   [junit4] OK      11.2s J1 | StreamDecoratorTest.testDaemonStream
   [junit4] OK      2.09s J1 | StreamDecoratorTest.testParallelCommitStream
   [junit4] OK      0.15s J1 | StreamDecoratorTest.testParallelHavingStream
   [junit4] OK      4.12s J1 | 
StreamDecoratorTest.testParallelDaemonCommitStream
   [junit4] OK      0.09s J1 | StreamDecoratorTest.testReducerStream
   [junit4] OK      2.09s J1 | StreamDecoratorTest.testCommitStream
   [junit4] OK      0.12s J1 | StreamDecoratorTest.testRankStream
   [junit4] OK      0.12s J1 | StreamDecoratorTest.testGetStreamForEOFTuple
   [junit4] OK      0.16s J1 | StreamDecoratorTest.testOuterHashJoinStream
   [junit4] OK      0.11s J1 | StreamDecoratorTest.testLetStream
   [junit4] OK      0.20s J1 | StreamDecoratorTest.testLeftOuterJoinStream
   [junit4] OK      2.92s J1 | StreamDecoratorTest.testUpdateStream
   [junit4] OK      0.09s J1 | 
StreamDecoratorTest.testHashJoinStreamWithKnownConflict
   [junit4] OK      0.13s J1 | StreamDecoratorTest.testParallelReducerStream
   [junit4] OK      0.13s J1 | StreamDecoratorTest.testIntersectStream
   [junit4] OK      3.21s J1 | 
StreamDecoratorTest.testParallelTerminatingDaemonUpdateStream
   [junit4] OK      0.13s J1 | StreamDecoratorTest.testHashJoinStream
   [junit4] OK      0.15s J1 | StreamDecoratorTest.testFetchStream
   [junit4] OK      0.17s J1 | StreamDecoratorTest.testParallelMergeStream
   [junit4] OK      0.21s J1 | StreamDecoratorTest.testMergeStream
   [junit4] OK      0.14s J1 | StreamDecoratorTest.testCartesianProductStream
   [junit4] OK      0.13s J1 | StreamDecoratorTest.testTerminatingDaemonStream
   [junit4] OK      0.12s J1 | StreamDecoratorTest.testUniqueStream
   [junit4] OK      0.11s J1 | StreamDecoratorTest.testParallelComplementStream
   [junit4] OK      0.10s J1 | StreamDecoratorTest.testParallelUniqueStream
   [junit4] OK      0.16s J1 | StreamDecoratorTest.testPriorityStream
   [junit4] OK      0.14s J1 | StreamDecoratorTest.testParallelRollupStream
   [junit4] OK      0.11s J1 | StreamDecoratorTest.testHavingStream
   [junit4] OK      2.15s J1 | StreamDecoratorTest.testParallelUpdateStream
   [junit4] OK      11.6s J1 | StreamDecoratorTest.testExecutorStream
   [junit4] OK      11.9s J1 | StreamDecoratorTest.testClassifyStream
   [junit4] Completed [5/5] on J1 in 75.61s, 47 tests
   [junit4] 
   [junit4] JVM J0:     0.71 ..   189.85 =   189.14s
   [junit4] JVM J1:     0.71 ..   264.87 =   264.15s
   [junit4] Execution time total: 4 minutes 24 seconds
   [junit4] Tests summary: 5 suites, 235 tests
   [junit4] Could not remove temporary path: 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-solrj/test/J1
 (java.nio.file.DirectoryNotEmptyException: Remaining files: 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-solrj/test/J1/temp])
   [junit4] Could not remove temporary path: 
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-solrj/test/J0
 (java.nio.file.DirectoryNotEmptyException: Remaining files: 
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-solrj/test/J0/temp])
     [echo] 5 slowest tests:
[junit4:tophints]  96.65s | 
org.apache.solr.client.solrj.impl.CloudSolrClientTest
[junit4:tophints]  83.37s | 
org.apache.solr.client.solrj.io.stream.StreamDecoratorTest
[junit4:tophints]  54.36s | 
org.apache.solr.common.cloud.TestCollectionStateWatchers
[junit4:tophints]  48.58s | org.apache.solr.client.solrj.request.SchemaTest
[junit4:tophints]  33.10s | org.apache.solr.client.solrj.request.TestCoreAdmin

-check-totals:

test-nocompile:

BUILD SUCCESSFUL
Total time: 4 minutes 27 seconds
[repro] Failures:
[repro]   0/5 failed: org.apache.solr.client.solrj.io.stream.StreamDecoratorTest
[repro]   0/5 failed: 
org.apache.solr.cloud.autoscaling.sim.TestSimTriggerIntegration
[repro] Exiting with code 0
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting 
ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
java.lang.InterruptedException: no matches found within 10000
        at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:2847)
        at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2726)
        at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2707)
        at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3086)
Also:   hudson.remoting.Channel$CallSiteStackTrace: Remote call to Solaris VBOX
                at 
hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1743)
                at 
hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:357)
                at hudson.remoting.Channel.call(Channel.java:957)
                at hudson.FilePath.act(FilePath.java:1072)
                at hudson.FilePath.act(FilePath.java:1061)
                at hudson.FilePath.validateAntFileMask(FilePath.java:2705)
                at 
hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
                at 
hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
                at 
hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
                at 
hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
                at 
hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
                at hudson.model.Build$BuildExecution.post2(Build.java:186)
                at 
hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
                at hudson.model.Run.execute(Run.java:1835)
                at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
                at 
hudson.model.ResourceController.execute(ResourceController.java:97)
                at hudson.model.Executor.run(Executor.java:429)
Caused: hudson.FilePath$TunneledInterruptedException
        at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3088)
        at hudson.remoting.UserRequest.perform(UserRequest.java:212)
        at hudson.remoting.UserRequest.perform(UserRequest.java:54)
        at hudson.remoting.Request$2.run(Request.java:369)
        at 
hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
        at java.util.concurrent.FutureTask.run(FutureTask.java:266)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
        at java.lang.Thread.run(Thread.java:748)
Caused: java.lang.InterruptedException: java.lang.InterruptedException: no 
matches found within 10000
        at hudson.FilePath.act(FilePath.java:1074)
        at hudson.FilePath.act(FilePath.java:1061)
        at hudson.FilePath.validateAntFileMask(FilePath.java:2705)
        at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
        at 
hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
        at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
        at 
hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
        at 
hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
        at hudson.model.Build$BuildExecution.post2(Build.java:186)
        at 
hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
        at hudson.model.Run.execute(Run.java:1835)
        at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
        at hudson.model.ResourceController.execute(ResourceController.java:97)
        at hudson.model.Executor.run(Executor.java:429)
No artifacts found that match the file pattern 
"**/*.events,heapdumps/**,**/*_pid*.log". Configuration error?
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting 
ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all 
warnings.
<Git Blamer> GIT_COMMIT=71f024ac8f1be7f74dceb84d91ea9d39a705172d, 
workspace=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris
[WARNINGS] Computing warning deltas based on reference build #2215
Recording test results
Setting 
ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting 
ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/export/home/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