Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.3-Windows/45/
Java: 64bit/jdk-10 -XX:+UseCompressedOops -XX:+UseG1GC
1 tests failed.
FAILED: org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.testTrigger
Error Message:
Stack Trace:
java.lang.AssertionError
at
__randomizedtesting.SeedInfo.seed([A409447E985B591E:C7C272FC01942A33]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertTrue(Assert.java:54)
at
org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.testTrigger(NodeAddedTriggerTest.java:111)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
Build Log:
[...truncated 14183 lines...]
[junit4] Suite: org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest
[junit4] 2> 2818821 INFO
(SUITE-NodeAddedTriggerTest-seed#[A409447E985B591E]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.NodeAddedTriggerTest_A409447E985B591E-001\init-core-data-001
[junit4] 2> 2818822 WARN
(SUITE-NodeAddedTriggerTest-seed#[A409447E985B591E]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 2818822 INFO
(SUITE-NodeAddedTriggerTest-seed#[A409447E985B591E]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 2818824 INFO
(SUITE-NodeAddedTriggerTest-seed#[A409447E985B591E]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0,
clientAuth=0.0/0.0)
[junit4] 2> 2818825 INFO
(SUITE-NodeAddedTriggerTest-seed#[A409447E985B591E]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in
C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.NodeAddedTriggerTest_A409447E985B591E-001\tempDir-001
[junit4] 2> 2818825 INFO
(SUITE-NodeAddedTriggerTest-seed#[A409447E985B591E]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2818825 INFO (Thread-4816) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2818825 INFO (Thread-4816) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 2818919 ERROR (Thread-4816) [ ] 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> 2818926 INFO
(SUITE-NodeAddedTriggerTest-seed#[A409447E985B591E]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:53374
[junit4] 2> 2818930 INFO (zkConnectionManagerCallback-6601-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2818932 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
0x1000676f1770000, likely client has closed socket
[junit4] 2> 2818934 INFO (jetty-launcher-6598-thread-1) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
????-??-??T??:??:??+08:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2818934 INFO (jetty-launcher-6598-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2818934 INFO (jetty-launcher-6598-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2818934 INFO (jetty-launcher-6598-thread-1) [ ]
o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 2818935 INFO (jetty-launcher-6598-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@41f9671f{/solr,null,AVAILABLE}
[junit4] 2> 2818938 INFO (jetty-launcher-6598-thread-1) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@66b84bb4{HTTP/1.1,[http/1.1]}{127.0.0.1:53378}
[junit4] 2> 2818938 INFO (jetty-launcher-6598-thread-1) [ ]
o.e.j.s.Server Started @2828981ms
[junit4] 2> 2818938 INFO (jetty-launcher-6598-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=53378}
[junit4] 2> 2818939 ERROR (jetty-launcher-6598-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2818939 INFO (jetty-launcher-6598-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.3.1
[junit4] 2> 2818939 INFO (jetty-launcher-6598-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2818939 INFO (jetty-launcher-6598-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2818939 INFO (jetty-launcher-6598-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-08T00:52:41.325475Z
[junit4] 2> 2818942 INFO (zkConnectionManagerCallback-6603-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2818943 INFO (jetty-launcher-6598-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2818950 INFO (jetty-launcher-6598-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:53374/solr
[junit4] 2> 2818952 INFO (zkConnectionManagerCallback-6607-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2818956 INFO
(zkConnectionManagerCallback-6609-thread-1-processing-n:127.0.0.1:53378_solr)
[n:127.0.0.1:53378_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2819062 INFO (jetty-launcher-6598-thread-1)
[n:127.0.0.1:53378_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2819063 INFO (jetty-launcher-6598-thread-1)
[n:127.0.0.1:53378_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:53378_solr
[junit4] 2> 2819064 INFO (jetty-launcher-6598-thread-1)
[n:127.0.0.1:53378_solr ] o.a.s.c.Overseer Overseer
(id=72064701964943363-127.0.0.1:53378_solr-n_0000000000) starting
[junit4] 2> 2819072 INFO
(zkConnectionManagerCallback-6614-thread-1-processing-n:127.0.0.1:53378_solr)
[n:127.0.0.1:53378_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2819075 INFO (jetty-launcher-6598-thread-1)
[n:127.0.0.1:53378_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:53374/solr ready
[junit4] 2> 2819076 INFO (jetty-launcher-6598-thread-1)
[n:127.0.0.1:53378_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:53378_solr
[junit4] 2> 2819077 INFO
(zkCallback-6613-thread-1-processing-n:127.0.0.1:53378_solr)
[n:127.0.0.1:53378_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 2819079 INFO
(zkCallback-6608-thread-1-processing-n:127.0.0.1:53378_solr)
[n:127.0.0.1:53378_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 2819118 INFO (jetty-launcher-6598-thread-1)
[n:127.0.0.1:53378_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_53378.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@611a0362
[junit4] 2> 2819124 INFO (jetty-launcher-6598-thread-1)
[n:127.0.0.1:53378_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_53378.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@611a0362
[junit4] 2> 2819124 INFO (jetty-launcher-6598-thread-1)
[n:127.0.0.1:53378_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_53378.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@611a0362
[junit4] 2> 2819125 INFO (jetty-launcher-6598-thread-1)
[n:127.0.0.1:53378_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.NodeAddedTriggerTest_A409447E985B591E-001\tempDir-001\node1\.
[junit4] 2> 2819140 INFO (zkConnectionManagerCallback-6616-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2819144 INFO (zkConnectionManagerCallback-6620-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2819145 INFO
(SUITE-NodeAddedTriggerTest-seed#[A409447E985B591E]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2819146 INFO
(SUITE-NodeAddedTriggerTest-seed#[A409447E985B591E]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:53374/solr ready
[junit4] 2> 2819154 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testRestoreState
[junit4] 2> 2819154 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E]) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
????-??-??T??:??:??+08:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2819159 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E]) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2819160 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E]) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2819160 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E]) [ ]
o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 2819160 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@5670911c{/solr,null,AVAILABLE}
[junit4] 2> 2819161 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@62d821ee{HTTP/1.1,[http/1.1]}{127.0.0.1:53399}
[junit4] 2> 2819161 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E]) [ ]
o.e.j.s.Server Started @2829203ms
[junit4] 2> 2819161 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=53399}
[junit4] 2> 2819161 ERROR
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2819161 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.3.1
[junit4] 2> 2819161 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2819161 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2819161 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-08T00:52:41.547078500Z
[junit4] 2> 2819163 INFO (zkConnectionManagerCallback-6622-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2819163 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E]) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2819171 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:53374/solr
[junit4] 2> 2819173 INFO (zkConnectionManagerCallback-6626-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2819177 INFO
(zkConnectionManagerCallback-6628-thread-1-processing-n:127.0.0.1:53399_solr)
[n:127.0.0.1:53399_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2819183 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E])
[n:127.0.0.1:53399_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 2819186 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E])
[n:127.0.0.1:53399_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2819187 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E])
[n:127.0.0.1:53399_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:53399_solr
[junit4] 2> 2819188 INFO
(zkCallback-6608-thread-1-processing-n:127.0.0.1:53378_solr)
[n:127.0.0.1:53378_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 2819188 INFO
(zkCallback-6613-thread-1-processing-n:127.0.0.1:53378_solr)
[n:127.0.0.1:53378_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 2819189 INFO
(zkCallback-6627-thread-1-processing-n:127.0.0.1:53399_solr)
[n:127.0.0.1:53399_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 2819190 INFO (zkCallback-6619-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2819239 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E])
[n:127.0.0.1:53399_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_53399.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@611a0362
[junit4] 2> 2819248 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E])
[n:127.0.0.1:53399_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_53399.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@611a0362
[junit4] 2> 2819248 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E])
[n:127.0.0.1:53399_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_53399.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@611a0362
[junit4] 2> 2819250 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E])
[n:127.0.0.1:53399_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.NodeAddedTriggerTest_A409447E985B591E-001\tempDir-001\node2\.
[junit4] 2> 2819253 INFO
(zkConnectionManagerCallback-6633-thread-1-processing-n:127.0.0.1:53399_solr)
[n:127.0.0.1:53399_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2819256 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E])
[n:127.0.0.1:53399_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 2819257 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E])
[n:127.0.0.1:53399_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:53374/solr ready
[junit4] 2> 2824290 INFO
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[A409447E985B591E]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testRestoreState
[junit4] 2> 2824300 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testTrigger
[junit4] 2> 2824301 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
????-??-??T??:??:??+08:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2824302 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2824302 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2824302 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 2824303 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@12f3bfca{/solr,null,AVAILABLE}
[junit4] 2> 2824303 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@36be1deb{HTTP/1.1,[http/1.1]}{127.0.0.1:53517}
[junit4] 2> 2824303 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.e.j.s.Server Started @2834347ms
[junit4] 2> 2824303 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=53517}
[junit4] 2> 2824305 ERROR
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2824305 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.3.1
[junit4] 2> 2824305 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2824305 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2824305 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-08T00:52:46.691138900Z
[junit4] 2> 2824307 INFO (zkConnectionManagerCallback-6635-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2824308 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2824314 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:53374/solr
[junit4] 2> 2824316 INFO (zkConnectionManagerCallback-6639-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2824319 INFO
(zkConnectionManagerCallback-6641-thread-1-processing-n:127.0.0.1:53517_solr)
[n:127.0.0.1:53517_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2824326 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E])
[n:127.0.0.1:53517_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 2824328 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E])
[n:127.0.0.1:53517_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2824330 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E])
[n:127.0.0.1:53517_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:53517_solr
[junit4] 2> 2824331 INFO
(zkCallback-6627-thread-1-processing-n:127.0.0.1:53399_solr)
[n:127.0.0.1:53399_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2824332 INFO
(zkCallback-6608-thread-1-processing-n:127.0.0.1:53378_solr)
[n:127.0.0.1:53378_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2824332 INFO (zkCallback-6619-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2824332 INFO
(zkCallback-6613-thread-1-processing-n:127.0.0.1:53378_solr)
[n:127.0.0.1:53378_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2824332 INFO
(zkCallback-6640-thread-1-processing-n:127.0.0.1:53517_solr)
[n:127.0.0.1:53517_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2824334 INFO
(zkCallback-6632-thread-1-processing-n:127.0.0.1:53399_solr)
[n:127.0.0.1:53399_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2824409 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E])
[n:127.0.0.1:53517_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_53517.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@611a0362
[junit4] 2> 2824416 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E])
[n:127.0.0.1:53517_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_53517.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@611a0362
[junit4] 2> 2824417 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E])
[n:127.0.0.1:53517_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_53517.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@611a0362
[junit4] 2> 2824418 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E])
[n:127.0.0.1:53517_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.NodeAddedTriggerTest_A409447E985B591E-001\tempDir-001\node3\.
[junit4] 2> 2824423 INFO
(zkConnectionManagerCallback-6646-thread-1-processing-n:127.0.0.1:53517_solr)
[n:127.0.0.1:53517_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2824424 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E])
[n:127.0.0.1:53517_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 2824424 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E])
[n:127.0.0.1:53517_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:53374/solr ready
[junit4] 2> 2824457 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
????-??-??T??:??:??+08:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2824457 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2824457 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2824457 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 2824457 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@5f58346{/solr,null,AVAILABLE}
[junit4] 2> 2824459 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@6b832d57{HTTP/1.1,[http/1.1]}{127.0.0.1:53532}
[junit4] 2> 2824459 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.e.j.s.Server Started @2834501ms
[junit4] 2> 2824459 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=53532}
[junit4] 2> 2824459 ERROR
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2824459 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.3.1
[junit4] 2> 2824459 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2824459 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2824459 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-08T00:52:46.845035300Z
[junit4] 2> 2824462 INFO (zkConnectionManagerCallback-6648-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2824463 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2824469 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:53374/solr
[junit4] 2> 2824471 INFO (zkConnectionManagerCallback-6652-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2824473 INFO
(zkConnectionManagerCallback-6654-thread-1-processing-n:127.0.0.1:53532_solr)
[n:127.0.0.1:53532_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2824480 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E])
[n:127.0.0.1:53532_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 2824482 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E])
[n:127.0.0.1:53532_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2824484 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E])
[n:127.0.0.1:53532_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:53532_solr
[junit4] 2> 2824485 INFO
(zkCallback-6640-thread-1-processing-n:127.0.0.1:53517_solr)
[n:127.0.0.1:53517_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2824485 INFO
(zkCallback-6608-thread-1-processing-n:127.0.0.1:53378_solr)
[n:127.0.0.1:53378_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2824485 INFO
(zkCallback-6627-thread-1-processing-n:127.0.0.1:53399_solr)
[n:127.0.0.1:53399_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2824485 INFO (zkCallback-6619-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2824485 INFO
(zkCallback-6632-thread-1-processing-n:127.0.0.1:53399_solr)
[n:127.0.0.1:53399_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2824485 INFO
(zkCallback-6613-thread-1-processing-n:127.0.0.1:53378_solr)
[n:127.0.0.1:53378_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2824486 INFO
(zkCallback-6645-thread-1-processing-n:127.0.0.1:53517_solr)
[n:127.0.0.1:53517_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2824486 INFO
(zkCallback-6653-thread-1-processing-n:127.0.0.1:53532_solr)
[n:127.0.0.1:53532_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2824537 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E])
[n:127.0.0.1:53532_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_53532.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@611a0362
[junit4] 2> 2824545 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E])
[n:127.0.0.1:53532_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_53532.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@611a0362
[junit4] 2> 2824545 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E])
[n:127.0.0.1:53532_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_53532.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@611a0362
[junit4] 2> 2824546 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E])
[n:127.0.0.1:53532_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.NodeAddedTriggerTest_A409447E985B591E-001\tempDir-001\node4\.
[junit4] 2> 2824550 INFO
(zkConnectionManagerCallback-6659-thread-1-processing-n:127.0.0.1:53532_solr)
[n:127.0.0.1:53532_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2824552 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E])
[n:127.0.0.1:53532_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 2824554 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E])
[n:127.0.0.1:53532_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:53374/solr ready
[junit4] 2> 2827595 INFO
(TEST-NodeAddedTriggerTest.testTrigger-seed#[A409447E985B591E]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testTrigger
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=NodeAddedTriggerTest -Dtests.method=testTrigger
-Dtests.seed=A409447E985B591E -Dtests.slow=true -Dtests.locale=mgh
-Dtests.timezone=Europe/Podgorica -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] FAILURE 3.31s J1 | NodeAddedTriggerTest.testTrigger <<<
[junit4] > Throwable #1: java.lang.AssertionError
[junit4] > at
__randomizedtesting.SeedInfo.seed([A409447E985B591E:C7C272FC01942A33]:0)
[junit4] > at
org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.testTrigger(NodeAddedTriggerTest.java:111)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] > at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at
java.base/java.lang.reflect.Method.invoke(Method.java:564)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> 2827619 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E]) [
] o.a.s.SolrTestCaseJ4 ###Starting testListenerAcceptance
[junit4] 2> 2827621 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E]) [
] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
????-??-??T??:??:??+08:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2827622 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E]) [
] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2827622 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E]) [
] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2827622 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E]) [
] o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 2827622 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E]) [
] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@671a5b29{/solr,null,AVAILABLE}
[junit4] 2> 2827623 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E]) [
] o.e.j.s.AbstractConnector Started
ServerConnector@22eee985{HTTP/1.1,[http/1.1]}{127.0.0.1:53547}
[junit4] 2> 2827623 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E]) [
] o.e.j.s.Server Started @2837666ms
[junit4] 2> 2827623 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E]) [
] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=53547}
[junit4] 2> 2827624 ERROR
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E]) [
] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2827624 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E]) [
] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.3.1
[junit4] 2> 2827624 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E]) [
] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port
null
[junit4] 2> 2827624 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E]) [
] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2827624 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E]) [
] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-08T00:52:50.010346600Z
[junit4] 2> 2827627 INFO (zkConnectionManagerCallback-6661-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2827628 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E]) [
] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2827637 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E]) [
] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:53374/solr
[junit4] 2> 2827640 INFO (zkConnectionManagerCallback-6665-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2827644 INFO
(zkConnectionManagerCallback-6667-thread-1-processing-n:127.0.0.1:53547_solr)
[n:127.0.0.1:53547_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2827653 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E])
[n:127.0.0.1:53547_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 2827656 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E])
[n:127.0.0.1:53547_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2827659 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E])
[n:127.0.0.1:53547_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:53547_solr
[junit4] 2> 2827661 INFO
(zkCallback-6653-thread-1-processing-n:127.0.0.1:53532_solr)
[n:127.0.0.1:53532_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (5)
[junit4] 2> 2827661 INFO
(zkCallback-6608-thread-1-processing-n:127.0.0.1:53378_solr)
[n:127.0.0.1:53378_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (5)
[junit4] 2> 2827661 INFO
(zkCallback-6640-thread-1-processing-n:127.0.0.1:53517_solr)
[n:127.0.0.1:53517_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (5)
[junit4] 2> 2827661 INFO (zkCallback-6619-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2827661 INFO
(zkCallback-6645-thread-1-processing-n:127.0.0.1:53517_solr)
[n:127.0.0.1:53517_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (5)
[junit4] 2> 2827662 INFO
(zkCallback-6627-thread-1-processing-n:127.0.0.1:53399_solr)
[n:127.0.0.1:53399_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (5)
[junit4] 2> 2827662 INFO
(zkCallback-6632-thread-1-processing-n:127.0.0.1:53399_solr)
[n:127.0.0.1:53399_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (5)
[junit4] 2> 2827662 INFO
(zkCallback-6613-thread-1-processing-n:127.0.0.1:53378_solr)
[n:127.0.0.1:53378_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (5)
[junit4] 2> 2827662 INFO
(zkCallback-6666-thread-1-processing-n:127.0.0.1:53547_solr)
[n:127.0.0.1:53547_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (5)
[junit4] 2> 2827663 INFO
(zkCallback-6658-thread-1-processing-n:127.0.0.1:53532_solr)
[n:127.0.0.1:53532_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (5)
[junit4] 2> 2827784 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E])
[n:127.0.0.1:53547_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_53547.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@611a0362
[junit4] 2> 2827797 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E])
[n:127.0.0.1:53547_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_53547.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@611a0362
[junit4] 2> 2827797 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E])
[n:127.0.0.1:53547_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_53547.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@611a0362
[junit4] 2> 2827798 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E])
[n:127.0.0.1:53547_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.NodeAddedTriggerTest_A409447E985B591E-001\tempDir-001\node5\.
[junit4] 2> 2827805 INFO
(zkConnectionManagerCallback-6672-thread-1-processing-n:127.0.0.1:53547_solr)
[n:127.0.0.1:53547_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2827807 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E])
[n:127.0.0.1:53547_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (5)
[junit4] 2> 2827808 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E])
[n:127.0.0.1:53547_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:53374/solr ready
[junit4] 2> 2827887 INFO
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[A409447E985B591E]) [
] o.a.s.SolrTestCaseJ4 ###Ending testListenerAcceptance
[junit4] 2> 2827914 INFO
(TEST-NodeAddedTriggerTest.testActionLifecycle-seed#[A409447E985B591E]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testActionLifecycle
[junit4] 2> 2827916 INFO
(TEST-NodeAddedTriggerTest.testActionLifecycle-seed#[A409447E985B591E]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testActionLifecycle
[junit4] 2> 2827918 INFO (jetty-closer-6599-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@66b84bb4{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 2827918 INFO (jetty-closer-6599-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@62d821ee{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 2827919 INFO (jetty-closer-6599-thread-3) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@36be1deb{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 2827919 INFO (jetty-closer-6599-thread-1) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=476349373
[junit4] 2> 2827920 INFO (jetty-closer-6599-thread-3) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=127765237
[junit4] 2> 2827920 INFO (jetty-closer-6599-thread-4) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@6b832d57{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 2827920 INFO (jetty-closer-6599-thread-5) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@22eee985{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 2827922 INFO (jetty-closer-6599-thread-4) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1185353561
[junit4] 2> 2827922 INFO (jetty-closer-6599-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2827922 INFO (jetty-closer-6599-thread-4) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2827920 INFO (jetty-closer-6599-thread-2) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1104953841
[junit4] 2> 2827922 INFO (jetty-closer-6599-thread-4) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@4628712c: rootName =
solr_53532, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@12bff42
[junit4] 2> 2827922 INFO (jetty-closer-6599-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1782311c: rootName =
solr_53517, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@4b40fe3f
[junit4] 2> 2827923 INFO (jetty-closer-6599-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2827923 INFO (jetty-closer-6599-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@4243a3dd: rootName =
solr_53399, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@7689e8ec
[junit4] 2> 2827922 INFO (jetty-closer-6599-thread-5) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1175599662
[junit4] 2> 2827922 INFO (jetty-closer-6599-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2827924 INFO (jetty-closer-6599-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@4bf62378: rootName =
solr_53378, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@ddb2fd6
[junit4] 2> 2827924 INFO (jetty-closer-6599-thread-5) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2827924 INFO (jetty-closer-6599-thread-5) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@37f47714: rootName =
solr_53547, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@53f3a0be
[junit4] 2> 2827951 INFO (jetty-closer-6599-thread-4) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2827952 INFO (jetty-closer-6599-thread-4) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1fd53757: rootName =
solr_53532, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@62e9b57d
[junit4] 2> 2827954 INFO (jetty-closer-6599-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2827954 INFO (jetty-closer-6599-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@c2cb091: rootName =
solr_53517, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@62e9b57d
[junit4] 2> 2827955 INFO (jetty-closer-6599-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2827955 INFO (jetty-closer-6599-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@494cc002: rootName =
solr_53399, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@62e9b57d
[junit4] 2> 2827959 INFO (jetty-closer-6599-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2827959 INFO (jetty-closer-6599-thread-5) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2827959 INFO (jetty-closer-6599-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@66a3084d: rootName =
solr_53378, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@62e9b57d
[junit4] 2> 2827959 INFO (jetty-closer-6599-thread-5) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@592d1e04: rootName =
solr_53547, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@62e9b57d
[junit4] 2> 2827975 INFO (jetty-closer-6599-thread-4) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2827975 INFO (jetty-closer-6599-thread-4) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@6dd1dcc: rootName =
solr_53532, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@5c953cff
[junit4] 2> 2827976 INFO (jetty-closer-6599-thread-4) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:53532_solr
[junit4] 2> 2827977 INFO (jetty-closer-6599-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2827977 INFO (jetty-closer-6599-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5f8942ae: rootName =
solr_53517, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@5c953cff
[junit4] 2> 2827979 INFO (jetty-closer-6599-thread-4) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2827979 INFO
(zkCallback-6658-thread-1-processing-n:127.0.0.1:53532_solr)
[n:127.0.0.1:53532_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (4)
[junit4] 2> 2827979 INFO
(zkCallback-6653-thread-1-processing-n:127.0.0.1:53532_solr)
[n:127.0.0.1:53532_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (4)
[junit4] 2> 2827979 INFO
(zkCallback-6608-thread-1-processing-n:127.0.0.1:53378_solr)
[n:127.0.0.1:53378_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (4)
[junit4] 2> 2827980 INFO
(zkCallback-6640-thread-1-processing-n:127.0.0.1:53517_solr)
[n:127.0.0.1:53517_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (4)
[junit4] 2> 2827980 INFO
(zkCallback-6666-thread-1-processing-n:127.0.0.1:53547_solr)
[n:127.0.0.1:53547_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (4)
[junit4] 2> 2827980 INFO
(zkCallback-6645-thread-1-processing-n:127.0.0.1:53517_solr)
[n:127.0.0.1:53517_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (4)
[junit4] 2> 2827980 INFO (jetty-closer-6599-thread-4) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 2827980 INFO
(zkCallback-6627-thread-1-processing-n:127.0.0.1:53399_solr)
[n:127.0.0.1:53399_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (4)
[junit4] 2> 2827980 INFO
(zkCallback-6632-thread-1-processing-n:127.0.0.1:53399_solr)
[n:127.0.0.1:53399_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (4)
[junit4] 2> 2827980 INFO
(zkCallback-6613-thread-1-processing-n:127.0.0.1:53378_solr)
[n:127.0.0.1:53378_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (4)
[junit4] 2> 2827981 INFO (jetty-closer-6599-thread-3) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:53517_solr
[junit4] 2> 2827981 INFO
(zkCallback-6671-thread-1-processing-n:127.0.0.1:53547_solr)
[n:127.0.0.1:53547_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (5) -> (4)
[junit4] 2> 2827982 INFO (jetty-closer-6599-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2827982 INFO (jetty-closer-6599-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@784bee92: rootName =
solr_53399, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@5c953cff
[junit4] 2> 2827982 INFO (jetty-closer-6599-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2827983 INFO (jetty-closer-6599-thread-3) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 2827984 INFO
(zkCallback-6640-thread-1-processing-n:127.0.0.1:53517_solr)
[n:127.0.0.1:53517_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2827984 INFO
(zkCallback-6645-thread-1-processing-n:127.0.0.1:53517_solr)
[n:127.0.0.1:53517_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2827984 INFO
(zkCallback-6627-thread-1-processing-n:127.0.0.1:53399_solr)
[n:127.0.0.1:53399_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2827984 INFO
(zkCallback-6632-thread-1-processing-n:127.0.0.1:53399_solr)
[n:127.0.0.1:53399_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2827984 INFO
(zkCallback-6671-thread-1-processing-n:127.0.0.1:53547_solr)
[n:127.0.0.1:53547_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2827984 INFO
(zkCallback-6666-thread-1-processing-n:127.0.0.1:53547_solr)
[n:127.0.0.1:53547_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2827984 INFO
(zkCallback-6608-thread-1-processing-n:127.0.0.1:53378_solr)
[n:127.0.0.1:53378_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2827986 INFO
(zkCallback-6613-thread-1-processing-n:127.0.0.1:53378_solr)
[n:127.0.0.1:53378_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 2827988 INFO (jetty-closer-6599-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2827988 INFO (jetty-closer-6599-thread-5) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2827988 INFO (jetty-closer-6599-thread-5) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@358dcf9f: rootName =
solr_53547, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@5c953cff
[junit4] 2> 2827988 INFO (jetty-closer-6599-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@250b1a57: rootName =
solr_53378, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@5c953cff
[junit4] 2> 2827989 INFO (jetty-closer-6599-thread-2) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:53399_solr
[junit4] 2> 2827989 INFO (jetty-closer-6599-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@12f3bfca{/solr,null,UNAVAILABLE}
[junit4] 2> 2827991 INFO (jetty-closer-6599-thread-3) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 2827992 INFO (jetty-closer-6599-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2827993 INFO (jetty-closer-6599-thread-2) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 2827994 INFO
(zkCallback-6666-thread-1-processing-n:127.0.0.1:53547_solr)
[n:127.0.0.1:53547_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (2)
[junit4] 2> 2827994 INFO (jetty-closer-6599-thread-1) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:53378_solr
[junit4] 2> 2827994 INFO (jetty-closer-6599-thread-5) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:53547_solr
[junit4] 2> 2827995 INFO
(zkCallback-6608-thread-1-processing-n:127.0.0.1:53378_solr)
[n:127.0.0.1:53378_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (2)
[junit4] 2> 2827995 INFO
(zkCallback-6613-thread-1-processing-n:127.0.0.1:53378_solr)
[n:127.0.0.1:53378_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (2)
[junit4] 2> 2827996 INFO
(zkCallback-6632-thread-1-processing-n:127.0.0.1:53399_solr)
[n:127.0.0.1:53399_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (2)
[junit4] 2> 2827996 INFO
(zkCallback-6627-thread-1-processing-n:127.0.0.1:53399_solr)
[n:127.0.0.1:53399_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (2)
[junit4] 2> 2827995 INFO
(zkCallback-6671-thread-1-processing-n:127.0.0.1:53547_solr)
[n:127.0.0.1:53547_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (2)
[junit4] 2> 2827997 INFO (jetty-closer-6599-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2827997 INFO (jetty-closer-6599-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 2827997 INFO (jetty-closer-6599-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72064701964943363-127.0.0.1:53378_solr-n_0000000000) closing
[junit4] 2> 2827999 WARN
(OverseerAutoScalingTriggerThread-72064701964943363-127.0.0.1:53378_solr-n_0000000000)
[n:127.0.0.1:53378_solr ] o.a.s.c.a.OverseerTriggerThread
OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 2827999 INFO (jetty-closer-6599-thread-5) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2827999 INFO
(OverseerStateUpdate-72064701964943363-127.0.0.1:53378_solr-n_0000000000)
[n:127.0.0.1:53378_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:53378_solr
[junit4] 2> 2827999 INFO (jetty-closer-6599-thread-5) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 2828001 INFO
(zkCallback-6608-thread-2-processing-n:127.0.0.1:53378_solr)
[n:127.0.0.1:53378_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (0)
[junit4] 2> 2828001 INFO
(zkCallback-6666-thread-1-processing-n:127.0.0.1:53547_solr)
[n:127.0.0.1:53547_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (0)
[junit4] 2> 2828001 INFO
(zkCallback-6671-thread-1-processing-n:127.0.0.1:53547_solr)
[n:127.0.0.1:53547_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (0)
[junit4] 2> 2828001 INFO
(zkCallback-6613-thread-1-processing-n:127.0.0.1:53378_solr)
[n:127.0.0.1:53378_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (0)
[junit4] 2> 2828004 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
0x1000676f1770003, likely client has closed socket
[junit4] 2> 2828004 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
0x1000676f1770015, likely client has closed socket
[junit4] 2> 2828005 INFO (jetty-closer-6599-thread-5) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@671a5b29{/solr,null,UNAVAILABLE}
[junit4] 2> 2828005 INFO (jetty-closer-6599-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@41f9671f{/solr,null,UNAVAILABLE}
[junit4] 2> 2828006 INFO (jetty-closer-6599-thread-5) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 2828006 INFO (jetty-closer-6599-thread-1) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 2829483 WARN
(zkCallback-6653-thread-1-processing-n:127.0.0.1:53532_solr)
[n:127.0.0.1:53532_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 2829484 INFO (jetty-closer-6599-thread-4) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@5f58346{/solr,null,UNAVAILABLE}
[junit4] 2> 2829484 INFO (jetty-closer-6599-thread-4) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 2829498 WARN
(zkCallback-6627-thread-1-processing-n:127.0.0.1:53399_solr)
[n:127.0.0.1:53399_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 2829499 INFO (jetty-closer-6599-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@5670911c{/solr,null,UNAVAILABLE}
[junit4] 2> 2829499 INFO (jetty-closer-6599-thread-2) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 2829500 ERROR
(SUITE-NodeAddedTriggerTest-seed#[A409447E985B591E]-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> 2829500 INFO
(SUITE-NodeAddedTriggerTest-seed#[A409447E985B591E]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:53374 53374
[junit4] 2> 2829501 INFO (Thread-4816) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:53374 53374
[junit4] 2> 2829502 WARN (Thread-4816) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 11 /solr/aliases.json
[junit4] 2> 11 /solr/clusterprops.json
[junit4] 2> 5 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 11 /solr/clusterstate.json
[junit4] 2> 2
/solr/overseer_elect/election/72064701964943369-127.0.0.1:53399_solr-n_0000000001
[junit4] 2> 2
/solr/overseer_elect/election/72064701964943363-127.0.0.1:53378_solr-n_0000000000
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 11 /solr/live_nodes
[junit4] 2> 11 /solr/collections
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.NodeAddedTriggerTest_A409447E985B591E-001
[junit4] 2> May 08, 2018 12:52:51 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=Asserting(Lucene70): {},
docValues:{}, maxPointsInLeafNode=1468, maxMBSortInHeap=7.563432976186211,
sim=RandomSimilarity(queryNorm=true): {}, locale=mgh, timezone=Europe/Podgorica
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 10
(64-bit)/cpus=3,threads=1,free=142063424,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [TestNRTOpen,
RollingRestartTest, SolrCLIZkUtilsTest, TlogReplayBufferedWhileIndexingTest,
TestDFRSimilarityFactory, TestTrackingShardHandlerFactory,
PreAnalyzedFieldTest, TermVectorComponentTest, DistributedSuggestComponentTest,
TestImpersonationWithHadoopAuth, HighlighterMaxOffsetTest,
TestSolrConfigHandler, DistributedQueueTest,
SpellCheckCollatorWithCollapseTest, DistributedIntervalFacetingTest,
TimeZoneUtilsTest, DistributedDebugComponentTest, TestFieldCache,
TestStressRecovery, TestSchemaVersionResource, TestZkAclsWithHadoopAuth,
ZkStateReaderTest, TestAddFieldRealTimeGet, ChangedSchemaMergeTest,
SimpleFacetsTest, TestClusterStateProvider, TestShardHandlerFactory,
SuggesterTest, TestCoreAdminApis, TestSchemaResource, TestLuceneMatchVersion,
RequestHandlersTest, TestFreeTextSuggestions, ImplicitSnitchTest,
TestLegacyNumericUtils, RegexBoostProcessorTest, HighlighterConfigTest,
TestTolerantUpdateProcessorRandomCloud, HdfsAutoAddReplicasIntegrationTest,
TestValueSourceCache, RegexBytesRefFilterTest, OverseerTaskQueueTest,
TestWriterPerf, TestPullReplicaErrorHandling,
ShufflingReplicaListTransformerTest, DistanceFunctionTest,
ConfigureRecoveryStrategyTest, TestLRUCache, TestDocBasedVersionConstraints,
ScriptEngineTest, TestSchemalessBufferedUpdates, TestCloudConsistency,
BigEndianAscendingWordSerializerTest, MissingSegmentRecoveryTest,
ReplicationFactorTest, ZkSolrClientTest, CdcrRequestHandlerTest,
FieldAnalysisRequestHandlerTest, RequestLoggingTest, TestRequestForwarding,
HdfsBasicDistributedZkTest, DistributedSpellCheckComponentTest,
TestChildDocTransformer, TestDynamicFieldResource, V2StandaloneTest,
TestMissingGroups, DistributedFacetPivotLongTailTest, TestExactStatsCache,
DateRangeFieldTest, LIROnShardRestartTest, UUIDFieldTest, TestHdfsUpdateLog,
TolerantUpdateProcessorTest, ChaosMonkeyNothingIsSafeTest,
TestConfigSetImmutable, ClassificationUpdateProcessorFactoryTest,
CircularListTest, TestStandardQParsers, TestPayloadCheckQParserPlugin,
TestNumericTerms64, SimpleCollectionCreateDeleteTest, TestRestManager,
TestSolrQueryParser, HdfsThreadLeakTest, ConnectionManagerTest,
VMParamsZkACLAndCredentialsProvidersTest, TestFieldTypeResource,
ConnectionReuseTest, BJQParserTest, TestSolrCloudSnapshots,
SecurityConfHandlerTest, TestScoreJoinQPScore, TestNodeAddedTrigger,
ResponseHeaderTest, SolrXmlInZkTest, TestQuerySenderListener,
SuggesterWFSTTest, UpdateRequestProcessorFactoryTest, TestManagedResource,
TestDocSet, FileBasedSpellCheckerTest, SearchHandlerTest, TokenizerChainTest,
AnalyticsMergeStrategyTest, ResponseLogComponentTest, TestCloudInspectUtil,
TestManagedSynonymFilterFactory, CdcrBidirectionalTest, TestClusterProperties,
TestUniqueKeyFieldResource, SortByFunctionTest, TestFieldResource,
PKIAuthenticationIntegrationTest, SimplePostToolTest,
TestLocalFSCloudBackupRestore, TestHdfsBackupRestoreCore,
SpellCheckComponentTest, TestStressVersions, TestRecoveryHdfs,
TestRawResponseWriter, EchoParamsTest, HLLSerializationTest, ZkShardTermsTest,
TestUseDocValuesAsStored, CreateRoutedAliasTest, TestDistributedMissingSort,
TestOrdValues, DirectoryFactoryTest, SolrCmdDistributorTest,
TestJsonFacetRefinement, CdcrUpdateLogTest, OverseerRolesTest,
TestAtomicUpdateErrorCases, LeaderElectionContextKeyTest, TestRandomDVFaceting,
TestTestInjection, SliceStateTest, FullSolrCloudDistribCmdsTest,
TestCollectionsAPIViaSolrCloudCluster, TestConfigReload, TestRandomFaceting,
TestNonDefinedSimilarityFactory, TestSolrCoreParser,
TestLegacyNumericRangeQueryBuilder, SolrMetricsIntegrationTest,
ExternalFileFieldSortTest, TestSearcherReuse, NoCacheHeaderTest,
DebugComponentTest, CloudExitableDirectoryReaderTest, TestDistributedSearch,
SoftAutoCommitTest, AddReplicaTest, QueryParsingTest, TestPointFields,
TestIndexingPerformance, TestTrieFacet, TestWordDelimiterFilterFactory,
TestManagedSchemaAPI, TestFilteredDocIdSet, TestMultiValuedNumericRangeQuery,
TestLegacyFieldCache, TestSimpleTrackingShardHandler, ClusterStateTest,
TestConfigSetsAPIExclusivity, HdfsUnloadDistributedZkTest,
DisMaxRequestHandlerTest, ZkControllerTest, LoggingHandlerTest,
OverseerCollectionConfigSetProcessorTest, StressHdfsTest,
TestEmbeddedSolrServerSchemaAPI, TestComponentsName, BadCopyFieldTest,
SparseHLLTest, TestCloudRecovery, TestCustomStream, HdfsRecoverLeaseTest,
MoveReplicaHDFSTest, RankQueryTest, TestSolr4Spatial, TestStressReorder,
TestMacros, SaslZkACLProviderTest, TestSort, SolrCoreCheckLockOnStartupTest,
TestAnalyzedSuggestions, TestCrossCoreJoin, BasicDistributedZkTest,
UnloadDistributedZkTest, SyncSliceTest, BasicZkTest, ClusterStateUpdateTest,
TestZkChroot, ZkCLITest, TestDistributedGrouping, TestHashPartitioner,
TermVectorComponentDistributedTest, TestRangeQuery, StatsComponentTest,
BadIndexSchemaTest, ConvertedLegacyTest, BasicFunctionalityTest,
DirectUpdateHandlerTest, TestBadConfig, TestIndexSearcher,
ShowFileRequestHandlerTest, TestCoreDiscovery, AnalysisAfterCoreReloadTest,
TestExtendedDismaxParser, SpellCheckCollatorTest, SolrRequestParserTest,
DocValuesTest, TestSolrDeletionPolicy1, XsltUpdateRequestHandlerTest,
TestQueryUtils, TestReversedWildcardFilterFactory, PrimitiveFieldTypeTest,
TestOmitPositions, XmlUpdateRequestHandlerTest, DocumentBuilderTest,
RequiredFieldsTest, SolrPluginUtilsTest, IndexSchemaTest, ReturnFieldsTest,
UniqFieldsUpdateProcessorFactoryTest, BinaryUpdateRequestHandlerTest,
TestPHPSerializedResponseWriter, SearchHandlerTest, MinimalSchemaTest,
OutputWriterTest, TestFuzzyAnalyzedSuggestions, NotRequiredUniqueKeyTest,
TestXIncludeConfig, TestPerFieldSimilarity, TestLMDirichletSimilarityFactory,
TestLMJelinekMercerSimilarityFactory, TestBM25SimilarityFactory,
TestFastOutputStream, URLClassifyProcessorTest, DateMathParserTest,
PrimUtilsTest, DOMUtilTest, TestDocumentBuilder, SystemInfoHandlerTest,
FileUtilsTest, TestRTGBase, TestHighlightDedupGrouping,
TestEmbeddedSolrServerAdminHandler, TestEmbeddedSolrServerConstructors,
ActionThrottleTest, AliasIntegrationTest,
ChaosMonkeySafeLeaderWithPullReplicasTest, CollectionStateFormat2Test,
ConcurrentCreateRoutedAliasTest, CreateCollectionCleanupTest,
DeleteLastCustomShardedReplicaTest, DeleteReplicaTest,
DistribDocExpirationUpdateProcessorTest, LeaderFailoverAfterPartitionTest,
LeaderFailureAfterFreshStartTest, LegacyCloudClusterPropTest,
MigrateRouteKeyTest, MultiThreadedOCPTest,
OutOfBoxZkACLAndCredentialsProvidersTest,
OverriddenZkACLAndCredentialsProvidersTest, OverseerStatusTest,
PeerSyncReplicationTest, RecoveryAfterSoftCommitTest,
TestAuthenticationFramework, TestCloudDeleteByQuery, TestCryptoKeys,
TestDistribDocBasedVersion, TestLeaderElectionZkExpiry, TestLockTree,
TestMiniSolrCloudClusterSSL, TestPrepRecovery, TestRandomRequestDistribution,
TestStressLiveNodes, TestTlogReplica, TestTolerantUpdateProcessorCloud,
TestUtilizeNode, CollectionTooManyReplicasTest,
CollectionsAPIDistributedZkTest, HttpTriggerListenerTest, MetricTriggerTest,
NodeAddedTriggerTest]
[junit4] Completed [592/783 (1!)] on J1 in 10.97s, 4 tests, 1 failure <<<
FAILURES!
[...truncated 43438 lines...]
[repro] Jenkins log URL:
https://jenkins.thetaphi.de/job/Lucene-Solr-7.3-Windows/45/consoleText
[repro] Revision: ae0705edb59eaa567fe13ed3a222fdadc7153680
[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC"
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr\core
[repro] NodeAddedTriggerTest
[repro] ant compile-test
[...truncated 3336 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5
-Dtests.class="*.NodeAddedTriggerTest" -Dtests.showOutput=onerror
"-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC" -Dtests.seed=A409447E985B591E
-Dtests.slow=true -Dtests.locale=mgh -Dtests.timezone=Europe/Podgorica
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
[...truncated 89 lines...]
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest
[repro] Exiting with code 0
[...truncated 75 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org
