Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/21875/
Java: 32bit/jdk1.8.0_162 -server -XX:+UseParallelGC

1 tests failed.
FAILED:  org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.testRestoreState

Error Message:
Did not expect the processor to fire on first run! event={   
"id":"67633013a75fcT20lb9r9fyaa7sloq9ujtssq1b",   
"source":"node_added_trigger",   "eventTime":1818811296282108,   
"eventType":"NODEADDED",   "properties":{     "eventTimes":[       
1818811296282108,       1818811296283604,       1818811296284012,       
1818811296284327],     "nodeNames":[       "127.0.0.1:36427_solr",       
"127.0.0.1:45217_solr",       "127.0.0.1:40659_solr",       
"127.0.0.1:43009_solr"]}}

Stack Trace:
java.lang.AssertionError: Did not expect the processor to fire on first run! 
event={
  "id":"67633013a75fcT20lb9r9fyaa7sloq9ujtssq1b",
  "source":"node_added_trigger",
  "eventTime":1818811296282108,
  "eventType":"NODEADDED",
  "properties":{
    "eventTimes":[
      1818811296282108,
      1818811296283604,
      1818811296284012,
      1818811296284327],
    "nodeNames":[
      "127.0.0.1:36427_solr",
      "127.0.0.1:45217_solr",
      "127.0.0.1:40659_solr",
      "127.0.0.1:43009_solr"]}}
        at 
__randomizedtesting.SeedInfo.seed([E45EAA5CA8E3CDFB:2AF00ECF50DAB5ED]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at 
org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.lambda$new$0(NodeAddedTriggerTest.java:49)
        at 
org.apache.solr.cloud.autoscaling.NodeAddedTrigger.run(NodeAddedTrigger.java:161)
        at 
org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.testRestoreState(NodeAddedTriggerTest.java:257)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 12510 lines...]
   [junit4] Suite: org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_E45EAA5CA8E3CDFB-001/init-core-data-001
   [junit4]   2> 76972 WARN  
(SUITE-NodeAddedTriggerTest-seed#[E45EAA5CA8E3CDFB]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=11 numCloses=11
   [junit4]   2> 76973 INFO  
(SUITE-NodeAddedTriggerTest-seed#[E45EAA5CA8E3CDFB]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 76974 INFO  
(SUITE-NodeAddedTriggerTest-seed#[E45EAA5CA8E3CDFB]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 76975 INFO  
(SUITE-NodeAddedTriggerTest-seed#[E45EAA5CA8E3CDFB]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 76975 INFO  
(SUITE-NodeAddedTriggerTest-seed#[E45EAA5CA8E3CDFB]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_E45EAA5CA8E3CDFB-001/tempDir-001
   [junit4]   2> 76975 INFO  
(SUITE-NodeAddedTriggerTest-seed#[E45EAA5CA8E3CDFB]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 76976 INFO  (Thread-114) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 76976 INFO  (Thread-114) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 76980 ERROR (Thread-114) [    ] o.a.z.s.ZooKeeperServer 
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action 
on ERROR or SHUTDOWN server state changes
   [junit4]   2> 77076 INFO  
(SUITE-NodeAddedTriggerTest-seed#[E45EAA5CA8E3CDFB]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:40397
   [junit4]   2> 77080 INFO  (zkConnectionManagerCallback-173-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 77097 INFO  (jetty-launcher-170-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-22T06:27:37+09:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 77117 INFO  (jetty-launcher-170-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 77117 INFO  (jetty-launcher-170-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 77117 INFO  (jetty-launcher-170-thread-1) [    ] 
o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 77120 INFO  (jetty-launcher-170-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@139ae01{/solr,null,AVAILABLE}
   [junit4]   2> 77143 INFO  (jetty-launcher-170-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@12b14b4{SSL,[ssl, 
http/1.1]}{127.0.0.1:36427}
   [junit4]   2> 77143 INFO  (jetty-launcher-170-thread-1) [    ] 
o.e.j.s.Server Started @77169ms
   [junit4]   2> 77143 INFO  (jetty-launcher-170-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=36427}
   [junit4]   2> 77144 ERROR (jetty-launcher-170-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 77144 INFO  (jetty-launcher-170-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 77144 INFO  (jetty-launcher-170-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 77144 INFO  (jetty-launcher-170-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 77144 INFO  (jetty-launcher-170-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 77144 INFO  (jetty-launcher-170-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-04-21T08:59:35.245Z
   [junit4]   2> 77164 INFO  (zkConnectionManagerCallback-175-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 77165 INFO  (jetty-launcher-170-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 77173 INFO  (jetty-launcher-170-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40397/solr
   [junit4]   2> 77177 INFO  (zkConnectionManagerCallback-179-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 77184 INFO  (zkConnectionManagerCallback-181-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 77239 INFO  (jetty-launcher-170-thread-1) 
[n:127.0.0.1:36427_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 77239 INFO  (jetty-launcher-170-thread-1) 
[n:127.0.0.1:36427_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:36427_solr
   [junit4]   2> 77240 INFO  (jetty-launcher-170-thread-1) 
[n:127.0.0.1:36427_solr    ] o.a.s.c.Overseer Overseer 
(id=72176790950838275-127.0.0.1:36427_solr-n_0000000000) starting
   [junit4]   2> 77253 INFO  (zkConnectionManagerCallback-188-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 77254 INFO  (jetty-launcher-170-thread-1) 
[n:127.0.0.1:36427_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:40397/solr ready
   [junit4]   2> 77257 INFO  (jetty-launcher-170-thread-1) 
[n:127.0.0.1:36427_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:36427_solr
   [junit4]   2> 77284 INFO  (zkCallback-187-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 77289 INFO  (zkCallback-180-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 78258 INFO  (jetty-launcher-170-thread-1) 
[n:127.0.0.1:36427_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_36427.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f44fcd
   [junit4]   2> 78262 INFO  (jetty-launcher-170-thread-1) 
[n:127.0.0.1:36427_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_36427.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f44fcd
   [junit4]   2> 78262 INFO  (jetty-launcher-170-thread-1) 
[n:127.0.0.1:36427_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_36427.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f44fcd
   [junit4]   2> 78263 INFO  (jetty-launcher-170-thread-1) 
[n:127.0.0.1:36427_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_E45EAA5CA8E3CDFB-001/tempDir-001/node1/.
   [junit4]   2> 78276 INFO  (zkConnectionManagerCallback-190-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 78281 INFO  (zkConnectionManagerCallback-195-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 78281 INFO  
(SUITE-NodeAddedTriggerTest-seed#[E45EAA5CA8E3CDFB]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 78282 INFO  
(SUITE-NodeAddedTriggerTest-seed#[E45EAA5CA8E3CDFB]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:40397/solr ready
   [junit4]   2> 78289 INFO  
(TEST-NodeAddedTriggerTest.testActionLifecycle-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testActionLifecycle
   [junit4]   2> 78314 INFO  
(TEST-NodeAddedTriggerTest.testActionLifecycle-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testActionLifecycle
   [junit4]   2> 78318 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testTrigger
   [junit4]   2> 78321 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-22T06:27:37+09:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 78338 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 78338 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 78338 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 78338 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@83ab5c{/solr,null,AVAILABLE}
   [junit4]   2> 78341 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@109da53{SSL,[ssl, 
http/1.1]}{127.0.0.1:45217}
   [junit4]   2> 78341 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.Server Started @78367ms
   [junit4]   2> 78341 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=45217}
   [junit4]   2> 78342 ERROR 
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 78342 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 78342 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 78342 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 78342 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 78342 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-04-21T08:59:36.443Z
   [junit4]   2> 78349 INFO  (zkConnectionManagerCallback-197-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 78350 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 78362 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40397/solr
   [junit4]   2> 78363 INFO  (zkConnectionManagerCallback-201-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 78369 INFO  (zkConnectionManagerCallback-203-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 78378 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:45217_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 78379 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:45217_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 78380 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:45217_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 78380 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:45217_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:45217_solr
   [junit4]   2> 78381 INFO  (zkCallback-187-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 78381 INFO  (zkCallback-180-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 78388 INFO  (zkCallback-194-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 78393 INFO  (zkCallback-202-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 78774 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:45217_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_45217.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f44fcd
   [junit4]   2> 78782 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:45217_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_45217.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f44fcd
   [junit4]   2> 78782 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:45217_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_45217.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f44fcd
   [junit4]   2> 78784 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:45217_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_E45EAA5CA8E3CDFB-001/tempDir-001/node2/.
   [junit4]   2> 78787 INFO  (zkConnectionManagerCallback-210-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 78788 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:45217_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 78789 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:45217_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:40397/solr ready
   [junit4]   2> 78811 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-22T06:27:37+09:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 78812 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 78812 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 78812 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 78812 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@5e3e18{/solr,null,AVAILABLE}
   [junit4]   2> 78813 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@1a8cbf9{SSL,[ssl, 
http/1.1]}{127.0.0.1:40659}
   [junit4]   2> 78813 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.Server Started @78839ms
   [junit4]   2> 78813 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=40659}
   [junit4]   2> 78813 ERROR 
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 78813 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 78813 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 78813 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 78813 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 78813 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-04-21T08:59:36.914Z
   [junit4]   2> 78815 INFO  (zkConnectionManagerCallback-212-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 78816 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 78822 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40397/solr
   [junit4]   2> 78823 INFO  (zkConnectionManagerCallback-216-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 78825 INFO  (zkConnectionManagerCallback-218-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 78829 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:40659_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 78830 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:40659_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 78831 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:40659_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 78831 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:40659_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:40659_solr
   [junit4]   2> 78831 INFO  (zkCallback-187-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 78832 INFO  (zkCallback-194-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 78832 INFO  (zkCallback-202-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 78832 INFO  (zkCallback-180-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 78836 INFO  (zkCallback-217-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 78837 INFO  (zkCallback-209-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 79440 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:40659_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_40659.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f44fcd
   [junit4]   2> 79446 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:40659_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_40659.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f44fcd
   [junit4]   2> 79447 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:40659_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_40659.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f44fcd
   [junit4]   2> 79448 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:40659_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_E45EAA5CA8E3CDFB-001/tempDir-001/node3/.
   [junit4]   2> 79454 INFO  (zkConnectionManagerCallback-225-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 79455 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:40659_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 79456 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:40659_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:40397/solr ready
   [junit4]   2> 81482 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-22T06:27:37+09:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 81483 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 81483 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 81483 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 81484 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@105f377{/solr,null,AVAILABLE}
   [junit4]   2> 81484 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@94412e{SSL,[ssl, 
http/1.1]}{127.0.0.1:34771}
   [junit4]   2> 81484 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.Server Started @81510ms
   [junit4]   2> 81484 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=34771}
   [junit4]   2> 81485 ERROR 
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 81485 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 81485 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 81485 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 81485 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 81485 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-04-21T08:59:39.586Z
   [junit4]   2> 81486 INFO  (zkConnectionManagerCallback-227-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 81487 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 81494 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40397/solr
   [junit4]   2> 81495 INFO  (zkConnectionManagerCallback-231-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 81497 INFO  (zkConnectionManagerCallback-233-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 81500 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:34771_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 81501 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:34771_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 81502 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:34771_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 81502 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:34771_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:34771_solr
   [junit4]   2> 81503 INFO  (zkCallback-180-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 81503 INFO  (zkCallback-217-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 81503 INFO  (zkCallback-194-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 81503 INFO  (zkCallback-202-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 81503 INFO  (zkCallback-187-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 81503 INFO  (zkCallback-209-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 81503 INFO  (zkCallback-224-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 81503 INFO  (zkCallback-232-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 82054 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:34771_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_34771.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f44fcd
   [junit4]   2> 82060 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:34771_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_34771.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f44fcd
   [junit4]   2> 82060 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:34771_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_34771.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f44fcd
   [junit4]   2> 82061 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:34771_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_E45EAA5CA8E3CDFB-001/tempDir-001/node4/.
   [junit4]   2> 82066 INFO  (zkConnectionManagerCallback-240-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 82067 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:34771_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (4)
   [junit4]   2> 82068 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:34771_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:40397/solr ready
   [junit4]   2> 82102 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@94412e{SSL,[ssl, 
http/1.1]}{127.0.0.1:0}
   [junit4]   2> 82102 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=14240581
   [junit4]   2> 82102 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 82102 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@db8396: rootName = 
solr_34771, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@15e92e4
   [junit4]   2> 82108 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 82108 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@607fea: rootName = 
solr_34771, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@14c6ab7
   [junit4]   2> 82111 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 82111 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1dce508: rootName = 
solr_34771, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@16cd561
   [junit4]   2> 82112 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:34771_solr
   [junit4]   2> 82112 INFO  (zkCallback-202-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 82112 INFO  (zkCallback-187-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 82113 INFO  (zkCallback-194-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 82113 INFO  (zkCallback-217-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 82113 INFO  (zkCallback-180-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 82113 INFO  (zkCallback-224-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 82113 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 82113 INFO  (zkCallback-239-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 82113 INFO  (zkCallback-209-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 82113 INFO  (zkCallback-232-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 82114 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@105f377{/solr,null,UNAVAILABLE}
   [junit4]   2> 82114 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 87115 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testTrigger
   [junit4]   2> 87130 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) [    
] o.a.s.SolrTestCaseJ4 ###Starting testListenerAcceptance
   [junit4]   2> 87132 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) [    
] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-22T06:27:37+09:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 87136 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) [    
] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 87136 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) [    
] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 87137 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) [    
] o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 87137 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) [    
] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@12bb26c{/solr,null,AVAILABLE}
   [junit4]   2> 87138 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) [    
] o.e.j.s.AbstractConnector Started ServerConnector@e43a7e{SSL,[ssl, 
http/1.1]}{127.0.0.1:43009}
   [junit4]   2> 87138 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) [    
] o.e.j.s.Server Started @87164ms
   [junit4]   2> 87138 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) [    
] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=43009}
   [junit4]   2> 87138 ERROR 
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) [    
] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 87138 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) [    
] o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 87138 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) [    
] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 87138 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) [    
] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port 
null
   [junit4]   2> 87138 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) [    
] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 87138 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) [    
] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-04-21T08:59:45.239Z
   [junit4]   2> 87143 INFO  (zkConnectionManagerCallback-242-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 87144 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) [    
] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 87157 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) [    
] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40397/solr
   [junit4]   2> 87160 INFO  (zkConnectionManagerCallback-246-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 87175 INFO  (zkConnectionManagerCallback-248-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 87180 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:43009_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 87181 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:43009_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 87183 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:43009_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 87183 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:43009_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:43009_solr
   [junit4]   2> 87187 INFO  (zkCallback-217-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 87187 INFO  (zkCallback-224-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 87187 INFO  (zkCallback-187-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 87187 INFO  (zkCallback-202-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 87187 INFO  (zkCallback-209-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 87187 INFO  (zkCallback-194-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 87187 INFO  (zkCallback-180-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 87193 INFO  (zkCallback-247-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 87664 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:43009_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43009.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f44fcd
   [junit4]   2> 87670 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:43009_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43009.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f44fcd
   [junit4]   2> 87670 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:43009_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43009.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f44fcd
   [junit4]   2> 87671 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:43009_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_E45EAA5CA8E3CDFB-001/tempDir-001/node5/.
   [junit4]   2> 87674 INFO  (zkConnectionManagerCallback-255-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 87675 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:43009_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (4)
   [junit4]   2> 87676 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:43009_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:40397/solr ready
   [junit4]   2> 87710 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[E45EAA5CA8E3CDFB]) [    
] o.a.s.SolrTestCaseJ4 ###Ending testListenerAcceptance
   [junit4]   2> 87724 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testRestoreState
   [junit4]   2> 87725 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-22T06:27:37+09:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 87726 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 87726 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 87726 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 87726 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@862622{/solr,null,AVAILABLE}
   [junit4]   2> 87726 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@35dbc6{SSL,[ssl, 
http/1.1]}{127.0.0.1:40689}
   [junit4]   2> 87727 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.e.j.s.Server Started @87753ms
   [junit4]   2> 87727 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=40689}
   [junit4]   2> 87727 ERROR 
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 87727 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 87727 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 87727 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 87727 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 87727 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-04-21T08:59:45.828Z
   [junit4]   2> 87732 INFO  (zkConnectionManagerCallback-257-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 87733 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 87744 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40397/solr
   [junit4]   2> 87745 INFO  (zkConnectionManagerCallback-261-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 87752 INFO  (zkConnectionManagerCallback-263-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 87756 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:40689_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (4)
   [junit4]   2> 87757 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:40689_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 87758 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:40689_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 87758 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:40689_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:40689_solr
   [junit4]   2> 87759 INFO  (zkCallback-194-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 87759 INFO  (zkCallback-224-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 87759 INFO  (zkCallback-202-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 87759 INFO  (zkCallback-180-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 87759 INFO  (zkCallback-209-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 87759 INFO  (zkCallback-217-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 87759 INFO  (zkCallback-187-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 87760 INFO  (zkCallback-247-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 87761 INFO  (zkCallback-254-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 87761 INFO  (zkCallback-262-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 89830 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:40689_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_40689.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f44fcd
   [junit4]   2> 89846 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:40689_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_40689.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f44fcd
   [junit4]   2> 89846 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:40689_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_40689.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f44fcd
   [junit4]   2> 89848 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:40689_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_E45EAA5CA8E3CDFB-001/tempDir-001/node6/.
   [junit4]   2> 89864 INFO  (zkConnectionManagerCallback-270-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 89865 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:40689_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (5)
   [junit4]   2> 89866 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) 
[n:127.0.0.1:40689_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:40397/solr ready
   [junit4]   2> 89904 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[E45EAA5CA8E3CDFB]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testRestoreState
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=NodeAddedTriggerTest -Dtests.method=testRestoreState 
-Dtests.seed=E45EAA5CA8E3CDFB -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=hu-HU -Dtests.timezone=Antarctica/Macquarie -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII
   [junit4] FAILURE 2.20s J0 | NodeAddedTriggerTest.testRestoreState <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: Did not expect the 
processor to fire on first run! event={
   [junit4]    >   "id":"67633013a75fcT20lb9r9fyaa7sloq9ujtssq1b",
   [junit4]    >   "source":"node_added_trigger",
   [junit4]    >   "eventTime":1818811296282108,
   [junit4]    >   "eventType":"NODEADDED",
   [junit4]    >   "properties":{
   [junit4]    >     "eventTimes":[
   [junit4]    >       1818811296282108,
   [junit4]    >       1818811296283604,
   [junit4]    >       1818811296284012,
   [junit4]    >       1818811296284327],
   [junit4]    >     "nodeNames":[
   [junit4]    >       "127.0.0.1:36427_solr",
   [junit4]    >       "127.0.0.1:45217_solr",
   [junit4]    >       "127.0.0.1:40659_solr",
   [junit4]    >       "127.0.0.1:43009_solr"]}}
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([E45EAA5CA8E3CDFB:2AF00ECF50DAB5ED]:0)
   [junit4]    >        at 
org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.lambda$new$0(NodeAddedTriggerTest.java:49)
   [junit4]    >        at 
org.apache.solr.cloud.autoscaling.NodeAddedTrigger.run(NodeAddedTrigger.java:161)
   [junit4]    >        at 
org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.testRestoreState(NodeAddedTriggerTest.java:257)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 89912 INFO  (jetty-closer-171-thread-3) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@1a8cbf9{SSL,[ssl, 
http/1.1]}{127.0.0.1:0}
   [junit4]   2> 89912 INFO  (jetty-closer-171-thread-1) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@12b14b4{SSL,[ssl, 
http/1.1]}{127.0.0.1:0}
   [junit4]   2> 89912 INFO  (jetty-closer-171-thread-2) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@109da53{SSL,[ssl, 
http/1.1]}{127.0.0.1:0}
   [junit4]   2> 89913 INFO  (jetty-closer-171-thread-1) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=29380319
   [junit4]   2> 89913 INFO  (jetty-closer-171-thread-3) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=32076761
   [junit4]   2> 89913 INFO  (jetty-closer-171-thread-2) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=33434907
   [junit4]   2> 89913 INFO  (jetty-closer-171-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 89913 INFO  (jetty-closer-171-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@8f72f: rootName = 
solr_36427, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@d2cf83
   [junit4]   2> 89913 INFO  (jetty-closer-171-thread-3) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 89913 INFO  (jetty-closer-171-thread-3) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1b08557: rootName = 
solr_40659, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@1de7c6
   [junit4]   2> 89914 INFO  (jetty-closer-171-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 89914 INFO  (jetty-closer-171-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1b7ec19: rootName = 
solr_45217, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@1421485
   [junit4]   2> 89914 INFO  (jetty-closer-171-thread-5) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@e43a7e{SSL,[ssl, 
http/1.1]}{127.0.0.1:0}
   [junit4]   2> 89914 INFO  (jetty-closer-171-thread-4) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@35dbc6{SSL,[ssl, 
http/1.1]}{127.0.0.1:0}
   [junit4]   2> 89915 INFO  (jetty-closer-171-thread-4) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=28819054
   [junit4]   2> 89915 INFO  (jetty-closer-171-thread-5) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=23419057
   [junit4]   2> 89915 INFO  (jetty-closer-171-thread-5) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 89915 INFO  (jetty-closer-171-thread-5) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@112c3c: rootName = 
solr_43009, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@12da62
   [junit4]   2> 89916 INFO  (jetty-closer-171-thread-4) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 89916 INFO  (jetty-closer-171-thread-4) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@4b949: rootName = 
solr_40689, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@17ee630
   [junit4]   2> 89923 INFO  (jetty-closer-171-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 89923 INFO  (jetty-closer-171-thread-3) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 89924 INFO  (jetty-closer-171-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@bf49f2: rootName = 
solr_36427, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@14c6ab7
   [junit4]   2> 89924 INFO  (jetty-closer-171-thread-3) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@194d71e: rootName = 
solr_40659, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@14c6ab7
   [junit4]   2> 89924 INFO  (jetty-closer-171-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 89924 INFO  (jetty-closer-171-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1e97498: rootName = 
solr_45217, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@14c6ab7
   [junit4]   2> 89924 INFO  (jetty-closer-171-thread-5) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 89925 INFO  (jetty-closer-171-thread-5) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2ea698: rootName = 
solr_43009, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@14c6ab7
   [junit4]   2> 89925 INFO  (jetty-closer-171-thread-4) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 89925 INFO  (jetty-closer-171-thread-4) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@6e8bd2: rootName = 
solr_40689, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@14c6ab7
   [junit4]   2> 89928 INFO  (jetty-closer-171-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 89928 INFO  (jetty-closer-171-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@182ff60: rootName = 
solr_36427, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@16cd561
   [junit4]   2> 89928 INFO  (jetty-closer-171-thread-3) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 89928 INFO  (jetty-closer-171-thread-3) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@160199c: rootName = 
solr_40659, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@16cd561
   [junit4]   2> 89928 INFO  (jetty-closer-171-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 89928 INFO  (jetty-closer-171-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@122e52: rootName = 
solr_45217, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@16cd561
   [junit4]   2> 89929 INFO  (jetty-closer-171-thread-5) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 89929 INFO  (jetty-closer-171-thread-5) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@147270: rootName = 
solr_43009, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@16cd561
   [junit4]   2> 89929 INFO  (jetty-closer-171-thread-1) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:36427_solr
   [junit4]   2> 89930 INFO  (jetty-closer-171-thread-4) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 89930 INFO  (jetty-closer-171-thread-4) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@18efe17: rootName = 
solr_40689, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@16cd561
   [junit4]   2> 89930 INFO  (jetty-closer-171-thread-3) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:40659_solr
   [junit4]   2> 89930 INFO  (jetty-closer-171-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 89930 INFO  (zkCallback-187-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 89931 INFO  (zkCallback-209-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (3)
   [junit4]   2> 89931 INFO  (jetty-closer-171-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 89931 INFO  (zkCallback-224-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (3)
   [junit4]   2> 89931 INFO  (zkCallback-254-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (3)
   [junit4]   2> 89931 INFO  (zkCallback-187-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 89931 INFO  (zkCallback-202-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 89931 INFO  (jetty-closer-171-thread-5) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:43009_solr
   [junit4]   2> 89931 INFO  (zkCallback-247-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (3)
   [junit4]   2> 89931 INFO  (zkCallback-217-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 89931 INFO  (zkCallback-180-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (3)
   [junit4]   2> 89931 INFO  (jetty-closer-171-thread-2) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:45217_solr
   [junit4]   2> 89931 INFO  (jetty-closer-171-thread-3) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 89931 INFO  (jetty-closer-171-thread-4) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:40689_solr
   [junit4]   2> 89932 INFO  (jetty-closer-171-thread-5) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 89932 INFO  (zkCallback-187-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
   [junit4]   2> 89932 INFO  (zkCallback-224-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
   [junit4]   2> 89932 INFO  (zkCallback-254-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
   [junit4]   2> 89932 INFO  (zkCallback-209-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
   [junit4]   2> 89933 INFO  (zkCallback-247-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
   [junit4]   2> 89933 INFO  (zkCallback-187-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 89933 INFO  (zkCallback-209-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 89933 INFO  (zkCallback-254-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 89933 INFO  (jetty-closer-171-thread-4) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 89933 INFO  (zkCallback-224-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 89933 INFO  (zkCallback-217-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (1)
   [junit4]   2> 89933 INFO  (jetty-closer-171-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 89934 INFO  (zkCallback-247-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 89934 INFO  (zkCallback-224-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 89934 INFO  (zkCallback-254-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 89934 INFO  (zkCallback-209-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 89934 INFO  (zkCallback-187-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 89934 INFO  (zkCallback-217-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 89936 INFO  (jetty-closer-171-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=72176790950838275-127.0.0.1:36427_solr-n_0000000000) closing
   [junit4]   2> 89937 INFO  (zkCallback-269-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (1)
   [junit4]   2> 89937 INFO  (zkCallback-262-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (0)
   [junit4]   2> 89937 INFO  (zkCallback-180-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (0)
   [junit4]   2> 89938 INFO  
(OverseerStateUpdate-72176790950838275-127.0.0.1:36427_solr-n_0000000000) [    
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:36427_solr
   [junit4]   2> 89940 INFO  (zkCallback-202-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (0)
   [junit4]   2> 89945 WARN  
(OverseerAutoScalingTriggerThread-72176790950838275-127.0.0.1:36427_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 89946 INFO  (zkCallback-269-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 89948 INFO  (jetty-closer-171-thread-3) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@5e3e18{/solr,null,UNAVAILABLE}
   [junit4]   2> 89948 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x1006c68b1a70009, likely client has closed socket
   [junit4]   2> 89949 INFO  (jetty-closer-171-thread-3) [    ] o.e.j.s.session 
Stopped scavenging
   [junit4]   2> 89950 INFO  (jetty-closer-171-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@83ab5c{/solr,null,UNAVAILABLE}
   [junit4]   2> 89950 INFO  (jetty-closer-171-thread-2) [    ] o.e.j.s.session 
Stopped scavenging
   [junit4]   2> 89951 INFO  (jetty-closer-171-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@139ae01{/solr,null,UNAVAILABLE}
   [junit4]   2> 89951 INFO  (jetty-closer-171-thread-1) [    ] o.e.j.s.session 
Stopped scavenging
   [junit4]   2> 91449 INFO  (jetty-closer-171-thread-5) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@12bb26c{/solr,null,UNAVAILABLE}
   [junit4]   2> 91449 INFO  (jetty-closer-171-thread-4) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@862622{/solr,null,UNAVAILABLE}
   [junit4]   2> 91449 INFO  (jetty-closer-171-thread-5) [    ] o.e.j.s.session 
Stopped scavenging
   [junit4]   2> 91449 INFO  (jetty-closer-171-thread-4) [    ] o.e.j.s.session 
Stopped scavenging
   [junit4]   2> 91450 ERROR 
(SUITE-NodeAddedTriggerTest-seed#[E45EAA5CA8E3CDFB]-worker) [    ] 
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper 
server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 91450 INFO  
(SUITE-NodeAddedTriggerTest-seed#[E45EAA5CA8E3CDFB]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:40397 40397
   [junit4]   2> 91578 INFO  (Thread-114) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:40397 40397
   [junit4]   2> 91579 WARN  (Thread-114) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        13      /solr/aliases.json
   [junit4]   2>        6       /solr/security.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        13      /solr/clusterstate.json
   [junit4]   2>        13      /solr/clusterprops.json
   [junit4]   2>        2       
/solr/overseer_elect/election/72176790950838285-127.0.0.1:40659_solr-n_0000000002
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        13      /solr/live_nodes
   [junit4]   2>        13      /solr/collections
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_E45EAA5CA8E3CDFB-001
   [junit4]   2> Apr 21, 2018 8:59:49 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Lucene70, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@8c8601),
 locale=hu-HU, timezone=Antarctica/Macquarie
   [junit4]   2> NOTE: Linux 4.13.0-37-generic i386/Oracle Corporation 
1.8.0_162 (32-bit)/cpus=8,threads=1,free=145106264,total=270270464
   [junit4]   2> NOTE: All tests run in this JVM: [TestConfig, 
SolrIndexSplitterTest, BadIndexSchemaTest, AddBlockUpdateTest, 
TestCloudRecovery, SmileWriterTest, CurrencyFieldTypeTest, 
TestSolrCloudSnapshots, TestSort, TokenizerChainTest, TestPseudoReturnFields, 
NodeAddedTriggerTest]
   [junit4] Completed [32/803 (1!)] on J0 in 15.62s, 4 tests, 1 failure <<< 
FAILURES!

[...truncated 48792 lines...]
[repro] Jenkins log URL: 
https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/21875/consoleText

[repro] Revision: 8f296d0ccf82174f9c612920ce25b928196a1fa8

[repro] Ant options: "-Dargs=-server -XX:+UseParallelGC"
[repro] Repro line:  ant test  -Dtestcase=NodeAddedTriggerTest 
-Dtests.method=testRestoreState -Dtests.seed=E45EAA5CA8E3CDFB 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=hu-HU 
-Dtests.timezone=Antarctica/Macquarie -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII

[repro] ant clean

[...truncated 6 lines...]
[repro] Test suites by module:
[repro]    solr/core
[repro]       NodeAddedTriggerTest
[repro] ant compile-test

[...truncated 3298 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.NodeAddedTriggerTest" -Dtests.showOutput=onerror 
"-Dargs=-server -XX:+UseParallelGC" -Dtests.seed=E45EAA5CA8E3CDFB 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=hu-HU 
-Dtests.timezone=Antarctica/Macquarie -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII

[...truncated 86 lines...]
[repro] Failures:
[repro]   0/5 failed: org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest
[repro] Exiting with code 0

[...truncated 40 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to