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