Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Solaris/1680/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC
2 tests failed.
FAILED: org.apache.solr.cloud.ReplaceNodeNoTargetTest.test
Error Message:
Stack Trace:
java.lang.AssertionError
at
__randomizedtesting.SeedInfo.seed([792D8D8468C3D3C8:F179B25EC63FBE30]: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.ReplaceNodeNoTargetTest.test(ReplaceNodeNoTargetTest.java:92)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED:
org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testMetricTrigger
Error Message:
Stack Trace:
java.lang.AssertionError
at
__randomizedtesting.SeedInfo.seed([792D8D8468C3D3C8:C321BA0B372B0587]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNull(Assert.java:551)
at org.junit.Assert.assertNull(Assert.java:562)
at
org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testMetricTrigger(TriggerIntegrationTest.java:1575)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 12836 lines...]
[junit4] Suite: org.apache.solr.cloud.autoscaling.TriggerIntegrationTest
[junit4] 2> Creating dataDir:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.TriggerIntegrationTest_792D8D8468C3D3C8-001/init-core-data-001
[junit4] 2> 1042922 WARN
(SUITE-TriggerIntegrationTest-seed#[792D8D8468C3D3C8]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=19 numCloses=19
[junit4] 2> 1042922 INFO
(SUITE-TriggerIntegrationTest-seed#[792D8D8468C3D3C8]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1042924 INFO
(SUITE-TriggerIntegrationTest-seed#[792D8D8468C3D3C8]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 1042924 INFO
(SUITE-TriggerIntegrationTest-seed#[792D8D8468C3D3C8]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1042924 INFO
(SUITE-TriggerIntegrationTest-seed#[792D8D8468C3D3C8]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.TriggerIntegrationTest_792D8D8468C3D3C8-001/tempDir-001
[junit4] 2> 1042924 INFO
(SUITE-TriggerIntegrationTest-seed#[792D8D8468C3D3C8]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1042925 INFO (Thread-1960) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1042925 INFO (Thread-1960) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1042926 ERROR (Thread-1960) [ ] 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> 1043025 INFO
(SUITE-TriggerIntegrationTest-seed#[792D8D8468C3D3C8]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:43998
[junit4] 2> 1043027 INFO (zkConnectionManagerCallback-1897-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1043032 INFO (jetty-launcher-1894-thread-1) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T21:27:37Z,
git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1043032 INFO (jetty-launcher-1894-thread-2) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T21:27:37Z,
git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1043034 INFO (jetty-launcher-1894-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1043034 INFO (jetty-launcher-1894-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1043034 INFO (jetty-launcher-1894-thread-1) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 1043035 INFO (jetty-launcher-1894-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1043035 INFO (jetty-launcher-1894-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1043036 INFO (jetty-launcher-1894-thread-2) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 1043036 INFO (jetty-launcher-1894-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@4cb56e6{/solr,null,AVAILABLE}
[junit4] 2> 1043036 INFO (jetty-launcher-1894-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@5fc39e7c{/solr,null,AVAILABLE}
[junit4] 2> 1043038 INFO (jetty-launcher-1894-thread-1) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@401b201d{HTTP/1.1,[http/1.1]}{127.0.0.1:62879}
[junit4] 2> 1043038 INFO (jetty-launcher-1894-thread-1) [ ]
o.e.j.s.Server Started @1047417ms
[junit4] 2> 1043038 INFO (jetty-launcher-1894-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=62879}
[junit4] 2> 1043038 ERROR (jetty-launcher-1894-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1043038 INFO (jetty-launcher-1894-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.0.0
[junit4] 2> 1043038 INFO (jetty-launcher-1894-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1043038 INFO (jetty-launcher-1894-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1043038 INFO (jetty-launcher-1894-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-02-15T20:15:14.879Z
[junit4] 2> 1043038 INFO (jetty-launcher-1894-thread-2) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@7b91b4a8{HTTP/1.1,[http/1.1]}{127.0.0.1:57885}
[junit4] 2> 1043040 INFO (jetty-launcher-1894-thread-2) [ ]
o.e.j.s.Server Started @1047420ms
[junit4] 2> 1043040 INFO (jetty-launcher-1894-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=57885}
[junit4] 2> 1043041 ERROR (jetty-launcher-1894-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1043041 INFO (jetty-launcher-1894-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.0.0
[junit4] 2> 1043041 INFO (jetty-launcher-1894-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1043041 INFO (jetty-launcher-1894-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1043041 INFO (jetty-launcher-1894-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-02-15T20:15:14.882Z
[junit4] 2> 1043044 INFO (zkConnectionManagerCallback-1899-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1043045 INFO (zkConnectionManagerCallback-1901-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1043045 INFO (jetty-launcher-1894-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1043045 INFO (jetty-launcher-1894-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1043054 INFO (jetty-launcher-1894-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43998/solr
[junit4] 2> 1043056 INFO (jetty-launcher-1894-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43998/solr
[junit4] 2> 1043057 INFO (zkConnectionManagerCallback-1906-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1043059 INFO (zkConnectionManagerCallback-1909-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1043061 INFO
(zkConnectionManagerCallback-1911-thread-1-processing-n:127.0.0.1:57885_solr)
[n:127.0.0.1:57885_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1043064 INFO
(zkConnectionManagerCallback-1913-thread-1-processing-n:127.0.0.1:62879_solr)
[n:127.0.0.1:62879_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1043266 INFO (jetty-launcher-1894-thread-2)
[n:127.0.0.1:57885_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1043268 INFO (jetty-launcher-1894-thread-2)
[n:127.0.0.1:57885_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:57885_solr
[junit4] 2> 1043271 INFO (jetty-launcher-1894-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1043272 INFO (jetty-launcher-1894-thread-2)
[n:127.0.0.1:57885_solr ] o.a.s.c.Overseer Overseer
(id=72204556508332037-127.0.0.1:57885_solr-n_0000000000) starting
[junit4] 2> 1043276 INFO (jetty-launcher-1894-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:62879_solr
[junit4] 2> 1043279 INFO
(zkCallback-1912-thread-1-processing-n:127.0.0.1:62879_solr)
[n:127.0.0.1:62879_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1043279 INFO
(zkCallback-1910-thread-1-processing-n:127.0.0.1:57885_solr)
[n:127.0.0.1:57885_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1043289 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread Adding
.autoAddReplicas trigger
[junit4] 2> 1043290 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing
/autoscaling.json with znode version 1
[junit4] 2> 1043291 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.NodeLostTrigger Initial livenodes:
[127.0.0.1:62879_solr]
[junit4] 2> 1043291 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread Current
znodeVersion 1, lastZnodeVersion -1
[junit4] 2> 1043291 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger
updates upto znodeVersion 1
[junit4] 2> 1043291 INFO (jetty-launcher-1894-thread-2)
[n:127.0.0.1:57885_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:57885_solr
[junit4] 2> 1043292 INFO
(zkCallback-1910-thread-1-processing-n:127.0.0.1:57885_solr)
[n:127.0.0.1:57885_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 1043293 INFO
(zkCallback-1912-thread-1-processing-n:127.0.0.1:62879_solr)
[n:127.0.0.1:62879_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 1043294 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old
nodeAdded markers
[junit4] 2> 1043295 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread Current
znodeVersion 1, lastZnodeVersion 1
[junit4] 2> 1043295 DEBUG (ScheduledTrigger-3732-thread-1)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: 2
[junit4] 2> 1043552 INFO (jetty-launcher-1894-thread-2)
[n:127.0.0.1:57885_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_57885.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d37af9f
[junit4] 2> 1043602 INFO (jetty-launcher-1894-thread-2)
[n:127.0.0.1:57885_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_57885.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d37af9f
[junit4] 2> 1043602 INFO (jetty-launcher-1894-thread-2)
[n:127.0.0.1:57885_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_57885.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d37af9f
[junit4] 2> 1043603 INFO (jetty-launcher-1894-thread-2)
[n:127.0.0.1:57885_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.TriggerIntegrationTest_792D8D8468C3D3C8-001/tempDir-001/node2/.
[junit4] 2> 1043624 INFO (jetty-launcher-1894-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_62879.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d37af9f
[junit4] 2> 1043634 INFO (jetty-launcher-1894-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_62879.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d37af9f
[junit4] 2> 1043634 INFO (jetty-launcher-1894-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_62879.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d37af9f
[junit4] 2> 1043635 INFO (jetty-launcher-1894-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.TriggerIntegrationTest_792D8D8468C3D3C8-001/tempDir-001/node1/.
[junit4] 2> 1043714 INFO (zkConnectionManagerCallback-1919-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1043723 INFO (zkConnectionManagerCallback-1923-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1043726 INFO
(SUITE-TriggerIntegrationTest-seed#[792D8D8468C3D3C8]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1043729 INFO
(SUITE-TriggerIntegrationTest-seed#[792D8D8468C3D3C8]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:43998/solr ready
[junit4] 2> 1043789 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testNodeAddedTriggerRestoreState
[junit4] 2> 1043791 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[ ] o.a.s.c.a.TriggerIntegrationTest /autoscaling.json reset, new znode
version 2
[junit4] 2> 1043792 DEBUG
(zkCallback-1910-thread-1-processing-n:127.0.0.1:57885_solr)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing
/autoscaling.json with znode version 2
[junit4] 2> 1043792 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger
updates upto znodeVersion 2
[junit4] 2> 1043800 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old
nodeLost markers
[junit4] 2> 1043802 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old
nodeAdded markers
[junit4] 2> 1043802 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread Current
znodeVersion 2, lastZnodeVersion 2
[junit4] 2> 1043826 INFO (qtp971591962-8442) [n:127.0.0.1:57885_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1043833 INFO (qtp2044474741-8430) [n:127.0.0.1:62879_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=2
[junit4] 2> 1043833 DEBUG (qtp971591962-8438) [n:127.0.0.1:57885_solr ]
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1043835 INFO (qtp971591962-8438) [n:127.0.0.1:57885_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=20
[junit4] 2> 1043835 DEBUG
(zkCallback-1910-thread-1-processing-n:127.0.0.1:57885_solr)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing
/autoscaling.json with znode version 3
[junit4] 2> 1043838 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-21T21:27:37Z, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1043844 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1043844 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1043844 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 1043845 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@2c444bf{/solr,null,AVAILABLE}
[junit4] 2> 1043845 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.AbstractConnector Started
ServerConnector@79870d6c{HTTP/1.1,[http/1.1]}{127.0.0.1:56980}
[junit4] 2> 1043845 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.Server Started @1048225ms
[junit4] 2> 1043845 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=56980}
[junit4] 2> 1043846 ERROR
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging
may be missing or incomplete.
[junit4] 2> 1043846 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™
version 8.0.0
[junit4] 2> 1043846 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on
port null
[junit4] 2> 1043846 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1043846 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-02-15T20:15:15.687Z
[junit4] 2> 1043846 DEBUG
(zkCallback-1910-thread-1-processing-n:127.0.0.1:57885_solr)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.NodeAddedTrigger Initial livenodes:
[127.0.0.1:62879_solr, 127.0.0.1:57885_solr]
[junit4] 2> 1043848 DEBUG
(zkCallback-1910-thread-1-processing-n:127.0.0.1:57885_solr)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger
node_added_restore_trigger instantiated with properties: {event=nodeAdded,
waitFor=5, actions=[{name=test,
class=org.apache.solr.cloud.autoscaling.TriggerIntegrationTest$TestTriggerAction}],
enabled=true}
[junit4] 2> 1043850 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger
updates upto znodeVersion 3
[junit4] 2> 1043854 INFO
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.TriggerIntegrationTest
TestTriggerAction init
[junit4] 2> 1043881 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old
nodeLost markers
[junit4] 2> 1043882 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread Current
znodeVersion 3, lastZnodeVersion 3
[junit4] 2> 1043882 DEBUG (ScheduledTrigger-3732-thread-3)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.NodeAddedTrigger Running
NodeAddedTrigger node_added_restore_trigger
[junit4] 2> 1043883 DEBUG (ScheduledTrigger-3732-thread-3)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
[junit4] 2> 1043886 INFO (zkConnectionManagerCallback-1925-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1043887 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1043925 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43998/solr
[junit4] 2> 1043929 INFO (zkConnectionManagerCallback-1929-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1043934 INFO
(zkConnectionManagerCallback-1931-thread-1-processing-n:127.0.0.1:56980_solr)
[n:127.0.0.1:56980_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1043959 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[n:127.0.0.1:56980_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 1043966 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[n:127.0.0.1:56980_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1043971 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[n:127.0.0.1:56980_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:56980_solr
[junit4] 2> 1043975 INFO
(zkCallback-1912-thread-1-processing-n:127.0.0.1:62879_solr)
[n:127.0.0.1:62879_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 1043975 INFO
(zkCallback-1910-thread-1-processing-n:127.0.0.1:57885_solr)
[n:127.0.0.1:57885_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 1043976 INFO (zkCallback-1922-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1043978 INFO
(zkCallback-1930-thread-1-processing-n:127.0.0.1:56980_solr)
[n:127.0.0.1:56980_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 1044180 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[n:127.0.0.1:56980_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_56980.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d37af9f
[junit4] 2> 1044222 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[n:127.0.0.1:56980_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_56980.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d37af9f
[junit4] 2> 1044222 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[n:127.0.0.1:56980_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_56980.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d37af9f
[junit4] 2> 1044224 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[n:127.0.0.1:56980_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.TriggerIntegrationTest_792D8D8468C3D3C8-001/tempDir-001/node3/.
[junit4] 2> 1044931 DEBUG (ScheduledTrigger-3732-thread-3)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.NodeAddedTrigger Running
NodeAddedTrigger node_added_restore_trigger
[junit4] 2> 1044931 DEBUG (ScheduledTrigger-3732-thread-3)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1044931 DEBUG (ScheduledTrigger-3732-thread-3)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.NodeAddedTrigger Tracking new node:
127.0.0.1:56980_solr at time 2242471343103884
[junit4] 2> 1045952 INFO (qtp941856464-8496) [n:127.0.0.1:56980_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1045956 INFO (qtp971591962-8442) [n:127.0.0.1:57885_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=4
[junit4] 2> 1045958 INFO (qtp2044474741-8435) [n:127.0.0.1:62879_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1045959 DEBUG (qtp2044474741-8430) [n:127.0.0.1:62879_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1045959 INFO (qtp2044474741-8430) [n:127.0.0.1:62879_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=9
[junit4] 2> 1045960 DEBUG
(zkCallback-1910-thread-1-processing-n:127.0.0.1:57885_solr)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing
/autoscaling.json with znode version 4
[junit4] 2> 1045961 DEBUG
(zkCallback-1910-thread-1-processing-n:127.0.0.1:57885_solr)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.NodeAddedTrigger Initial livenodes:
[127.0.0.1:62879_solr, 127.0.0.1:57885_solr, 127.0.0.1:56980_solr]
[junit4] 2> 1045961 DEBUG
(zkCallback-1910-thread-1-processing-n:127.0.0.1:57885_solr)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger
node_added_restore_trigger instantiated with properties: {event=nodeAdded,
waitFor=0, actions=[{name=test,
class=org.apache.solr.cloud.autoscaling.TriggerIntegrationTest$TestTriggerAction}],
enabled=true}
[junit4] 2> 1045961 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger
updates upto znodeVersion 4
[junit4] 2> 1045962 INFO
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.TriggerIntegrationTest
TestTriggerAction init
[junit4] 2> 1045963 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.NodeAddedTrigger Adding node from
marker path: 127.0.0.1:56980_solr
[junit4] 2> 1045964 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old
nodeLost markers
[junit4] 2> 1045964 DEBUG (ScheduledTrigger-3732-thread-1)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.NodeAddedTrigger Running
NodeAddedTrigger node_added_restore_trigger
[junit4] 2> 1045964 DEBUG (ScheduledTrigger-3732-thread-1)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1045964 DEBUG (ScheduledTrigger-3732-thread-1)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger
node_added_restore_trigger firing registered processor for nodes:
[127.0.0.1:56980_solr] added at times [2242472375148192], now=2242472376153835
[junit4] 2> 1045964 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread Current
znodeVersion 4, lastZnodeVersion 4
[junit4] 2> 1045964 DEBUG (ScheduledTrigger-3732-thread-1)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown
inactive - processing event: {
[junit4] 2> "id":"7f7844956dea0T5gzpz6eiifwk4h9k39qqs4563",
[junit4] 2> "source":"node_added_restore_trigger",
[junit4] 2> "eventTime":2242472375148192,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[2242472375148192],
[junit4] 2> "nodeNames":["127.0.0.1:56980_solr"]}}
[junit4] 2> 1045965 DEBUG (ScheduledTrigger-3732-thread-1)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.ScheduledTriggers Pausing all triggers:
[node_added_restore_trigger]
[junit4] 2> 1045965 INFO (ScheduledTrigger-3732-thread-1)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.SystemLogListener Collection .system
does not exist, disabling logging.
[junit4] 2> 1045966 DEBUG
(AutoscalingActionExecutor-3733-thread-1-processing-n:127.0.0.1:57885_solr)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.ScheduledTriggers -- processing actions
for {
[junit4] 2> "id":"7f7844956dea0T5gzpz6eiifwk4h9k39qqs4563",
[junit4] 2> "source":"node_added_restore_trigger",
[junit4] 2> "eventTime":2242472375148192,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[2242472375148192],
[junit4] 2> "_enqueue_time_":2242472377021080,
[junit4] 2> "nodeNames":["127.0.0.1:56980_solr"]}}
[junit4] 2> 1045966 INFO
(TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[792D8D8468C3D3C8])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testNodeAddedTriggerRestoreState
[junit4] 2> 1045969 DEBUG
(AutoscalingActionExecutor-3733-thread-1-processing-n:127.0.0.1:57885_solr)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.ScheduledTriggers Resuming trigger:
node_added_restore_trigger after 5000ms
[junit4] 2> 1045969 DEBUG
(AutoscalingActionExecutor-3733-thread-1-processing-n:127.0.0.1:57885_solr)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.ScheduledTriggers -- processing took 2
ms for event id=7f7844956dea0T5gzpz6eiifwk4h9k39qqs4563
[junit4] 2> 1045990 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testContinueTriggersOnOverseerRestart
[junit4] 2> 1045991 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.c.a.TriggerIntegrationTest /autoscaling.json reset, new znode
version 5
[junit4] 2> 1045991 DEBUG
(zkCallback-1910-thread-1-processing-n:127.0.0.1:57885_solr)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing
/autoscaling.json with znode version 5
[junit4] 2> 1045992 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger
updates upto znodeVersion 5
[junit4] 2> 1045993 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old
nodeLost markers
[junit4] 2> 1045994 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old
nodeAdded markers
[junit4] 2> 1045994 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread Current
znodeVersion 5, lastZnodeVersion 5
[junit4] 2> 1045995 INFO (qtp941856464-8495) [n:127.0.0.1:56980_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with
params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1046005 INFO (qtp941856464-8495) [n:127.0.0.1:56980_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=9
[junit4] 2> 1046009 INFO (qtp941856464-8497) [n:127.0.0.1:56980_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1046010 INFO (qtp971591962-8442) [n:127.0.0.1:57885_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1046012 INFO (qtp2044474741-8430) [n:127.0.0.1:62879_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1046012 DEBUG (qtp941856464-8493) [n:127.0.0.1:56980_solr ]
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1046013 INFO (qtp941856464-8493) [n:127.0.0.1:56980_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=6
[junit4] 2> 1046013 DEBUG
(zkCallback-1910-thread-1-processing-n:127.0.0.1:57885_solr)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing
/autoscaling.json with znode version 6
[junit4] 2> 1046014 DEBUG
(zkCallback-1910-thread-1-processing-n:127.0.0.1:57885_solr)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.NodeAddedTrigger Initial livenodes:
[127.0.0.1:62879_solr, 127.0.0.1:57885_solr, 127.0.0.1:56980_solr]
[junit4] 2> 1046014 DEBUG
(zkCallback-1910-thread-1-processing-n:127.0.0.1:57885_solr)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger
node_added_triggerCTOOR instantiated with properties: {event=nodeAdded,
waitFor=2, actions=[{name=test,
class=org.apache.solr.cloud.autoscaling.TriggerIntegrationTest$TestTriggerAction}],
enabled=true}
[junit4] 2> 1046014 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger
updates upto znodeVersion 6
[junit4] 2> 1046016 INFO
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.TriggerIntegrationTest
TestTriggerAction init
[junit4] 2> 1046017 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old
nodeLost markers
[junit4] 2> 1046018 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread Current
znodeVersion 6, lastZnodeVersion 6
[junit4] 2> 1046018 DEBUG (ScheduledTrigger-3732-thread-4)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.NodeAddedTrigger Running
NodeAddedTrigger node_added_triggerCTOOR
[junit4] 2> 1046018 DEBUG (ScheduledTrigger-3732-thread-4)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1046018 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.AbstractConnector Stopped
ServerConnector@7b91b4a8{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 1046019 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=314553774
[junit4] 2> 1046019 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.node, tag=null
[junit4] 2> 1046019 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@79b7d637: rootName =
solr_57885, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@d67e436
[junit4] 2> 1046025 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jvm, tag=null
[junit4] 2> 1046025 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@36e31eaf: rootName =
solr_57885, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@458f0059
[junit4] 2> 1046030 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jetty, tag=null
[junit4] 2> 1046030 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1aa60210: rootName =
solr_57885, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@24bce6da
[junit4] 2> 1046032 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:57885_solr
[junit4] 2> 1046034 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.cluster, tag=null
[junit4] 2> 1046034 INFO (zkCallback-1922-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 1046034 INFO
(zkCallback-1910-thread-1-processing-n:127.0.0.1:57885_solr)
[n:127.0.0.1:57885_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (2)
[junit4] 2> 1046034 INFO
(zkCallback-1912-thread-1-processing-n:127.0.0.1:62879_solr)
[n:127.0.0.1:62879_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (2)
[junit4] 2> 1046034 INFO
(zkCallback-1930-thread-1-processing-n:127.0.0.1:56980_solr)
[n:127.0.0.1:56980_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (2)
[junit4] 2> 1046035 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 1046035 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.c.Overseer Overseer
(id=72204556508332037-127.0.0.1:57885_solr-n_0000000000) closing
[junit4] 2> 1046035 INFO
(OverseerStateUpdate-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:57885_solr
[junit4] 2> 1046036 WARN
(OverseerAutoScalingTriggerThread-72204556508332037-127.0.0.1:57885_solr-n_0000000000)
[n:127.0.0.1:57885_solr ] o.a.s.c.a.OverseerTriggerThread
OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 1046038 DEBUG
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed
explicitly
[junit4] 2> 1046040 INFO
(zkCallback-1912-thread-1-processing-n:127.0.0.1:62879_solr)
[n:127.0.0.1:62879_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:62879_solr
[junit4] 2> 1046041 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@5fc39e7c{/solr,null,UNAVAILABLE}
[junit4] 2> 1046041 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 1046044 INFO
(zkCallback-1912-thread-1-processing-n:127.0.0.1:62879_solr)
[n:127.0.0.1:62879_solr ] o.a.s.c.Overseer Overseer
(id=72204556508332038-127.0.0.1:62879_solr-n_0000000001) starting
[junit4] 2> 1046054 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332038-127.0.0.1:62879_solr-n_0000000001)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.OverseerTriggerThread Adding
.autoAddReplicas trigger
[junit4] 2> 1046056 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332038-127.0.0.1:62879_solr-n_0000000001)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing
/autoscaling.json with znode version 7
[junit4] 2> 1046056 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332038-127.0.0.1:62879_solr-n_0000000001)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Initial livenodes:
[127.0.0.1:62879_solr, 127.0.0.1:56980_solr]
[junit4] 2> 1046056 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332038-127.0.0.1:62879_solr-n_0000000001)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger
node_added_triggerCTOOR instantiated with properties: {event=nodeAdded,
waitFor=2, actions=[{name=test,
class=org.apache.solr.cloud.autoscaling.TriggerIntegrationTest$TestTriggerAction}],
enabled=true}
[junit4] 2> 1046057 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332038-127.0.0.1:62879_solr-n_0000000001)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeLostTrigger Initial livenodes:
[127.0.0.1:62879_solr, 127.0.0.1:56980_solr]
[junit4] 2> 1046057 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332038-127.0.0.1:62879_solr-n_0000000001)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.OverseerTriggerThread Current
znodeVersion 7, lastZnodeVersion -1
[junit4] 2> 1046057 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332038-127.0.0.1:62879_solr-n_0000000001)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger
updates upto znodeVersion 7
[junit4] 2> 1046058 INFO
(OverseerAutoScalingTriggerThread-72204556508332038-127.0.0.1:62879_solr-n_0000000001)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.TriggerIntegrationTest
TestTriggerAction init
[junit4] 2> 1046060 DEBUG (ScheduledTrigger-3747-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Running
NodeAddedTrigger node_added_triggerCTOOR
[junit4] 2> 1046060 DEBUG (ScheduledTrigger-3747-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
[junit4] 2> 1046063 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332038-127.0.0.1:62879_solr-n_0000000001)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.OverseerTriggerThread Current
znodeVersion 7, lastZnodeVersion 7
[junit4] 2> 1046064 DEBUG (ScheduledTrigger-3747-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: 2
[junit4] 2> 1047064 DEBUG (ScheduledTrigger-3747-thread-2)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Running
NodeAddedTrigger node_added_triggerCTOOR
[junit4] 2> 1047064 DEBUG (ScheduledTrigger-3747-thread-2)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
[junit4] 2> 1047067 DEBUG (ScheduledTrigger-3747-thread-3)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: 2
[junit4] 2> 1048065 DEBUG (ScheduledTrigger-3747-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Running
NodeAddedTrigger node_added_triggerCTOOR
[junit4] 2> 1048065 DEBUG (ScheduledTrigger-3747-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
[junit4] 2> 1048067 DEBUG (ScheduledTrigger-3747-thread-4)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: 2
[junit4] 2> 1049066 DEBUG (ScheduledTrigger-3747-thread-2)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Running
NodeAddedTrigger node_added_triggerCTOOR
[junit4] 2> 1049066 DEBUG (ScheduledTrigger-3747-thread-2)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
[junit4] 2> 1049067 DEBUG (ScheduledTrigger-3747-thread-3)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: 2
[junit4] 2> 1050067 DEBUG (ScheduledTrigger-3747-thread-4)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: 2
[junit4] 2> 1050067 DEBUG (ScheduledTrigger-3747-thread-3)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Running
NodeAddedTrigger node_added_triggerCTOOR
[junit4] 2> 1050067 DEBUG (ScheduledTrigger-3747-thread-3)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
[junit4] 2> 1051068 DEBUG (ScheduledTrigger-3747-thread-4)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: 2
[junit4] 2> 1051068 DEBUG (ScheduledTrigger-3747-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Running
NodeAddedTrigger node_added_triggerCTOOR
[junit4] 2> 1051068 DEBUG (ScheduledTrigger-3747-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
[junit4] 2> 1052069 DEBUG (ScheduledTrigger-3747-thread-4)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: 2
[junit4] 2> 1052070 DEBUG (ScheduledTrigger-3747-thread-4)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Running
NodeAddedTrigger node_added_triggerCTOOR
[junit4] 2> 1052070 DEBUG (ScheduledTrigger-3747-thread-4)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
[junit4] 2> 1053075 DEBUG (ScheduledTrigger-3747-thread-4)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: 2
[junit4] 2> 1053075 DEBUG (ScheduledTrigger-3747-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Running
NodeAddedTrigger node_added_triggerCTOOR
[junit4] 2> 1053076 DEBUG (ScheduledTrigger-3747-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
[junit4] 2> 1054080 DEBUG (ScheduledTrigger-3747-thread-4)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: 2
[junit4] 2> 1054080 DEBUG (ScheduledTrigger-3747-thread-2)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Running
NodeAddedTrigger node_added_triggerCTOOR
[junit4] 2> 1054080 DEBUG (ScheduledTrigger-3747-thread-2)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
[junit4] 2> 1055081 DEBUG (ScheduledTrigger-3747-thread-4)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: 2
[junit4] 2> 1055081 DEBUG (ScheduledTrigger-3747-thread-4)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Running
NodeAddedTrigger node_added_triggerCTOOR
[junit4] 2> 1055081 DEBUG (ScheduledTrigger-3747-thread-4)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
[junit4] 2> 1056044 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-21T21:27:37Z, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1056045 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1056045 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1056045 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 1056045 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@31caba72{/solr,null,AVAILABLE}
[junit4] 2> 1056046 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.AbstractConnector Started
ServerConnector@5454b6f5{HTTP/1.1,[http/1.1]}{127.0.0.1:36325}
[junit4] 2> 1056046 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.Server Started @1060429ms
[junit4] 2> 1056046 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=36325}
[junit4] 2> 1056046 ERROR
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging
may be missing or incomplete.
[junit4] 2> 1056047 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™
version 8.0.0
[junit4] 2> 1056047 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on
port null
[junit4] 2> 1056047 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1056047 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-02-15T20:15:27.888Z
[junit4] 2> 1056050 INFO (zkConnectionManagerCallback-1935-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1056051 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1056085 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43998/solr
[junit4] 2> 1056088 INFO (zkConnectionManagerCallback-1939-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1056112 INFO
(zkConnectionManagerCallback-1941-thread-1-processing-n:127.0.0.1:36325_solr)
[n:127.0.0.1:36325_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1056121 DEBUG (ScheduledTrigger-3747-thread-4)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: 2
[junit4] 2> 1056121 DEBUG (ScheduledTrigger-3747-thread-2)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Running
NodeAddedTrigger node_added_triggerCTOOR
[junit4] 2> 1056121 DEBUG (ScheduledTrigger-3747-thread-2)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
[junit4] 2> 1056144 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[n:127.0.0.1:36325_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 1056156 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[n:127.0.0.1:36325_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1056161 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[n:127.0.0.1:36325_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:36325_solr
[junit4] 2> 1056180 INFO (zkCallback-1922-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1056180 INFO
(zkCallback-1912-thread-1-processing-n:127.0.0.1:62879_solr)
[n:127.0.0.1:62879_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 1056210 INFO
(zkCallback-1940-thread-1-processing-n:127.0.0.1:36325_solr)
[n:127.0.0.1:36325_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 1056229 INFO
(zkCallback-1930-thread-1-processing-n:127.0.0.1:56980_solr)
[n:127.0.0.1:56980_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 1056382 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[n:127.0.0.1:36325_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36325.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d37af9f
[junit4] 2> 1056393 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[n:127.0.0.1:36325_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36325.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d37af9f
[junit4] 2> 1056393 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[n:127.0.0.1:36325_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36325.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d37af9f
[junit4] 2> 1056395 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[n:127.0.0.1:36325_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.TriggerIntegrationTest_792D8D8468C3D3C8-001/tempDir-001/node4/.
[junit4] 2> 1057123 DEBUG (ScheduledTrigger-3747-thread-4)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: 3
[junit4] 2> 1057123 DEBUG (ScheduledTrigger-3747-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Running
NodeAddedTrigger node_added_triggerCTOOR
[junit4] 2> 1057123 DEBUG (ScheduledTrigger-3747-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1057123 DEBUG (ScheduledTrigger-3747-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Tracking new node:
127.0.0.1:36325_solr at time 2242483538882990
[junit4] 2> 1058133 DEBUG (ScheduledTrigger-3747-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Running
NodeAddedTrigger node_added_triggerCTOOR
[junit4] 2> 1058133 DEBUG (ScheduledTrigger-3747-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1058133 DEBUG (ScheduledTrigger-3747-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: 3
[junit4] 2> 1059134 DEBUG (ScheduledTrigger-3747-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Running
NodeAddedTrigger node_added_triggerCTOOR
[junit4] 2> 1059134 DEBUG (ScheduledTrigger-3747-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1059134 DEBUG (ScheduledTrigger-3747-thread-4)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: 3
[junit4] 2> 1059134 DEBUG (ScheduledTrigger-3747-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger
node_added_triggerCTOOR firing registered processor for nodes:
[127.0.0.1:36325_solr] added at times [2242483538882990], now=2242485551172100
[junit4] 2> 1059134 DEBUG (ScheduledTrigger-3747-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown
inactive - processing event: {
[junit4] 2> "id":"7f786e2bff1aeT5gzpz6eiifwk4h9k39qqs4565",
[junit4] 2> "source":"node_added_triggerCTOOR",
[junit4] 2> "eventTime":2242483538882990,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[2242483538882990],
[junit4] 2> "nodeNames":["127.0.0.1:36325_solr"]}}
[junit4] 2> 1059135 DEBUG (ScheduledTrigger-3747-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.ScheduledTriggers Pausing all triggers:
[.auto_add_replicas, node_added_triggerCTOOR]
[junit4] 2> 1059137 INFO (ScheduledTrigger-3747-thread-1)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.SystemLogListener Collection .system
does not exist, disabling logging.
[junit4] 2> 1059138 DEBUG
(AutoscalingActionExecutor-3748-thread-1-processing-n:127.0.0.1:62879_solr)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.ScheduledTriggers -- processing actions
for {
[junit4] 2> "id":"7f786e2bff1aeT5gzpz6eiifwk4h9k39qqs4565",
[junit4] 2> "source":"node_added_triggerCTOOR",
[junit4] 2> "eventTime":2242483538882990,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[2242483538882990],
[junit4] 2> "_enqueue_time_":2242485551898126,
[junit4] 2> "nodeNames":["127.0.0.1:36325_solr"]}}
[junit4] 2> 1059138 INFO
(TEST-TriggerIntegrationTest.testContinueTriggersOnOverseerRestart-seed#[792D8D8468C3D3C8])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testContinueTriggersOnOverseerRestart
[junit4] 2> 1059145 DEBUG
(AutoscalingActionExecutor-3748-thread-1-processing-n:127.0.0.1:62879_solr)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.ScheduledTriggers Resuming trigger:
.auto_add_replicas after 5000ms
[junit4] 2> 1059145 DEBUG
(AutoscalingActionExecutor-3748-thread-1-processing-n:127.0.0.1:62879_solr)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.ScheduledTriggers Resuming trigger:
node_added_triggerCTOOR after 5000ms
[junit4] 2> 1059145 DEBUG
(AutoscalingActionExecutor-3748-thread-1-processing-n:127.0.0.1:62879_solr)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.ScheduledTriggers -- processing took 7
ms for event id=7f786e2bff1aeT5gzpz6eiifwk4h9k39qqs4565
[junit4] 2> 1059164 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testNodeMarkersRegistration
[junit4] 2> 1059169 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.c.a.TriggerIntegrationTest /autoscaling.json reset, new znode
version 8
[junit4] 2> 1059169 DEBUG
(zkCallback-1912-thread-1-processing-n:127.0.0.1:62879_solr)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing
/autoscaling.json with znode version 8
[junit4] 2> 1059170 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332038-127.0.0.1:62879_solr-n_0000000001)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger
updates upto znodeVersion 8
[junit4] 2> 1059173 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332038-127.0.0.1:62879_solr-n_0000000001)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old
nodeLost markers
[junit4] 2> 1059173 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332038-127.0.0.1:62879_solr-n_0000000001)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old
nodeAdded markers
[junit4] 2> 1059174 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332038-127.0.0.1:62879_solr-n_0000000001)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.OverseerTriggerThread Current
znodeVersion 8, lastZnodeVersion 8
[junit4] 2> 1059174 INFO (qtp40599192-8533) [n:127.0.0.1:36325_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with
params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1059188 INFO (qtp40599192-8533) [n:127.0.0.1:36325_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=14
[junit4] 2> 1059193 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-21T21:27:37Z, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1059194 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1059194 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1059194 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 1059194 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@21897677{/solr,null,AVAILABLE}
[junit4] 2> 1059195 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.AbstractConnector Started
ServerConnector@5f6bb286{HTTP/1.1,[http/1.1]}{127.0.0.1:52300}
[junit4] 2> 1059195 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.Server Started @1063580ms
[junit4] 2> 1059195 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=52300}
[junit4] 2> 1059195 ERROR
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging
may be missing or incomplete.
[junit4] 2> 1059195 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™
version 8.0.0
[junit4] 2> 1059195 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on
port null
[junit4] 2> 1059195 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1059195 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-02-15T20:15:31.036Z
[junit4] 2> 1059198 INFO (zkConnectionManagerCallback-1945-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1059198 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1059204 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
0x10085a95dd8000f, likely client has closed socket
[junit4] 2> 1059216 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43998/solr
[junit4] 2> 1059219 INFO (zkConnectionManagerCallback-1949-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1059222 INFO
(zkConnectionManagerCallback-1951-thread-1-processing-n:127.0.0.1:52300_solr)
[n:127.0.0.1:52300_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1059238 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[n:127.0.0.1:52300_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 1059241 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[n:127.0.0.1:52300_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1059245 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[n:127.0.0.1:52300_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:52300_solr
[junit4] 2> 1059246 INFO
(zkCallback-1930-thread-1-processing-n:127.0.0.1:56980_solr)
[n:127.0.0.1:56980_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 1059246 INFO (zkCallback-1922-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1059246 INFO
(zkCallback-1940-thread-1-processing-n:127.0.0.1:36325_solr)
[n:127.0.0.1:36325_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 1059248 INFO
(zkCallback-1950-thread-1-processing-n:127.0.0.1:52300_solr)
[n:127.0.0.1:52300_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 1059248 INFO
(zkCallback-1912-thread-1-processing-n:127.0.0.1:62879_solr)
[n:127.0.0.1:62879_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 1059354 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[n:127.0.0.1:52300_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_52300.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d37af9f
[junit4] 2> 1059365 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[n:127.0.0.1:52300_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_52300.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d37af9f
[junit4] 2> 1059365 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[n:127.0.0.1:52300_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_52300.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d37af9f
[junit4] 2> 1059366 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[n:127.0.0.1:52300_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.TriggerIntegrationTest_792D8D8468C3D3C8-001/tempDir-001/node5/.
[junit4] 2> 1059413 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.c.a.TriggerIntegrationTest ====== KILL OVERSEER 1
[junit4] 2> 1059414 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.AbstractConnector Stopped
ServerConnector@401b201d{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 1059414 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=665069995
[junit4] 2> 1059415 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.node, tag=null
[junit4] 2> 1059415 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@4f2146e3: rootName =
solr_62879, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@48515435
[junit4] 2> 1059420 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jvm, tag=null
[junit4] 2> 1059421 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@7fc4b1bf: rootName =
solr_62879, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@458f0059
[junit4] 2> 1059424 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jetty, tag=null
[junit4] 2> 1059424 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@7099df38: rootName =
solr_62879, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@24bce6da
[junit4] 2> 1059427 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:62879_solr
[junit4] 2> 1059428 INFO
(zkCallback-1950-thread-1-processing-n:127.0.0.1:52300_solr)
[n:127.0.0.1:52300_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 1059429 INFO
(zkCallback-1940-thread-1-processing-n:127.0.0.1:36325_solr)
[n:127.0.0.1:36325_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 1059429 INFO
(zkCallback-1930-thread-1-processing-n:127.0.0.1:56980_solr)
[n:127.0.0.1:56980_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 1059429 INFO (zkCallback-1922-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1059430 INFO
(zkCallback-1912-thread-1-processing-n:127.0.0.1:62879_solr)
[n:127.0.0.1:62879_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 1059430 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.cluster, tag=null
[junit4] 2> 1059430 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 1059431 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.c.Overseer Overseer
(id=72204556508332038-127.0.0.1:62879_solr-n_0000000001) closing
[junit4] 2> 1059431 INFO
(OverseerStateUpdate-72204556508332038-127.0.0.1:62879_solr-n_0000000001)
[n:127.0.0.1:62879_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:62879_solr
[junit4] 2> 1059431 WARN
(OverseerAutoScalingTriggerThread-72204556508332038-127.0.0.1:62879_solr-n_0000000001)
[n:127.0.0.1:62879_solr ] o.a.s.c.a.OverseerTriggerThread
OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 1059433 DEBUG
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed
explicitly
[junit4] 2> 1059435 INFO
(zkCallback-1930-thread-1-processing-n:127.0.0.1:56980_solr)
[n:127.0.0.1:56980_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:56980_solr
[junit4] 2> 1059436 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@4cb56e6{/solr,null,UNAVAILABLE}
[junit4] 2> 1059437 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 1059439 INFO
(zkCallback-1930-thread-1-processing-n:127.0.0.1:56980_solr)
[n:127.0.0.1:56980_solr ] o.a.s.c.Overseer Overseer
(id=72204556508332043-127.0.0.1:56980_solr-n_0000000002) starting
[junit4] 2> 1059447 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332043-127.0.0.1:56980_solr-n_0000000002)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.OverseerTriggerThread Adding
.autoAddReplicas trigger
[junit4] 2> 1059449 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332043-127.0.0.1:56980_solr-n_0000000002)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing
/autoscaling.json with znode version 9
[junit4] 2> 1059450 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332043-127.0.0.1:56980_solr-n_0000000002)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.NodeLostTrigger Initial livenodes:
[127.0.0.1:52300_solr, 127.0.0.1:36325_solr, 127.0.0.1:56980_solr]
[junit4] 2> 1059450 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332043-127.0.0.1:56980_solr-n_0000000002)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.OverseerTriggerThread Current
znodeVersion 9, lastZnodeVersion -1
[junit4] 2> 1059450 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332043-127.0.0.1:56980_solr-n_0000000002)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger
updates upto znodeVersion 9
[junit4] 2> 1059454 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332043-127.0.0.1:56980_solr-n_0000000002)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old
nodeAdded markers
[junit4] 2> 1059454 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332043-127.0.0.1:56980_solr-n_0000000002)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.OverseerTriggerThread Current
znodeVersion 9, lastZnodeVersion 9
[junit4] 2> 1059455 DEBUG (ScheduledTrigger-3764-thread-1)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: 3
[junit4] 2> 1060458 DEBUG (ScheduledTrigger-3764-thread-1)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: 3
[junit4] 2> 1061459 DEBUG (ScheduledTrigger-3764-thread-1)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: 3
[junit4] 2> 1062460 DEBUG (ScheduledTrigger-3764-thread-1)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: 3
[junit4] 2> 1063461 DEBUG (ScheduledTrigger-3764-thread-1)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: 3
[junit4] 2> 1064438 INFO
(TEST-TriggerIntegrationTest.testNodeMarkersRegistration-seed#[792D8D8468C3D3C8])
[ ] o.a.s.c.a.TriggerIntegrationTest ====== ADD TRIGGERS
[junit4] 2> 1064445 INFO (qtp40599192-8538) [n:127.0.0.1:36325_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1064454 INFO (qtp1220820547-8563) [n:127.0.0.1:52300_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=6
[junit4] 2> 1064457 INFO (qtp941856464-8493) [n:127.0.0.1:56980_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1064457 DEBUG (qtp40599192-8535) [n:127.0.0.1:36325_solr ]
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1064458 INFO (qtp40599192-8535) [n:127.0.0.1:36325_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=17
[junit4] 2> 1064459 DEBUG
(zkCallback-1930-thread-1-processing-n:127.0.0.1:56980_solr)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing
/autoscaling.json with znode version 10
[junit4] 2> 1064461 DEBUG
(zkCallback-1930-thread-1-processing-n:127.0.0.1:56980_solr)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.NodeAddedTrigger Initial livenodes:
[127.0.0.1:52300_solr, 127.0.0.1:36325_solr, 127.0.0.1:56980_solr]
[junit4] 2> 1064461 DEBUG
(zkCallback-1930-thread-1-processing-n:127.0.0.1:56980_solr)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger
node_added_triggerMR instantiated with properties: {event=nodeAdded, waitFor=1,
actions=[{name=test,
class=org.apache.solr.cloud.autoscaling.TriggerIntegrationTest$TestEventMarkerAction}],
enabled=true}
[junit4] 2> 1064462 DEBUG
(zkCallback-1930-thread-1-processing-n:127.0.0.1:56980_solr)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.NodeLostTrigger Initial livenodes:
[127.0.0.1:52300_solr, 127.0.0.1:36325_solr, 127.0.0.1:56980_solr]
[junit4] 2> 1064462 DEBUG (ScheduledTrigger-3764-thread-1)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: 3
[junit4] 2> 1064463 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332043-127.0.0.1:56980_solr-n_0000000002)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger
updates upto znodeVersion 10
[junit4] 2> 1064467 INFO
(OverseerAutoScalingTriggerThread-72204556508332043-127.0.0.1:56980_solr-n_0000000002)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.TriggerIntegrationTest
TestEventMarkerAction init
[junit4] 2> 1064468 INFO (qtp40599192-8535) [n:127.0.0.1:36325_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1064469 DEBUG
(OverseerAutoScalingTriggerThread-72204556508332043-127.0.0.1:56980_solr-n_0000000002)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.OverseerTriggerThread Current
znodeVersion 10, lastZnodeVersion 10
[junit4] 2> 1064469 DEBUG (ScheduledTrigger-3764-thread-2)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.NodeAddedTrigger Running
NodeAddedTrigger node_added_triggerMR
[junit4] 2> 1064470 DEBUG (ScheduledTrigger-3764-thread-2)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1064471 INFO (qtp1220820547-8561) [n:127.0.0.1:52300_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1064476 INFO (qtp941856464-8493) [n:127.0.0.1:56980_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1064476 DEBUG (qtp1220820547-8560) [n:127.0.0.1:52300_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1064478 INFO (qtp1220820547-8560) [n:127.0.0.1:52300_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=15
[junit4] 2> 1064478 INFO (qtp40599192-8537) [n:127.0.0.1:36325_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with
params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1064479 DEBUG
(zkCallback-1930-thread-1-processing-n:127.0.0.1:56980_solr)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing
/autoscaling.json with znode version 11
[junit4] 2> 1064480 DEBUG
(zkCallback-1930-thread-1-processing-n:127.0.0.1:56980_solr)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.NodeLostTrigger Initial livenodes:
[127.0.0.1:52300_solr, 127.0.0.1:36325_solr, 127.0.0.1:56980_solr]
[junit4] 2> 1064481 DEBUG
(zkCallback-1930-thread-1-processing-n:127.0.0.1:56980_solr)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.NodeAddedTrigger Initial livenodes:
[127.0.0.1:52300_solr, 127.0.0.1:36325_solr, 127.0.0.1:56980_solr]
[junit4] 2> 1064481 DEBUG
(zkCallback-1930-thread-1-processing-n:127.0.0.1:56980_solr)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger
node_added_triggerMR instantiated with properties: {event=nodeAdded, waitFor=1,
actions=[{name=test,
class=org.apache.solr.cloud.autoscaling.TriggerIntegrationTest$TestEventMarkerAction}],
enabled=true}
[junit4] 2> 1064481 DEBUG
(zkCallback-1930-thread-1-processing-n:127.0.0.1:56980_solr)
[n:127.0.0.1:56980_solr ] o.a.s.c.a.NodeLostTrigger Initial livenod
[...truncated too long message...]
ssing-n:127.0.0.1:63144_solr) [n:127.0.0.1:63144_solr
c:replacenodetest_coll_notarget s:shard1 r:core_node22
x:replacenodetest_coll_notarget_shard1_replica_n21] o.a.s.m.SolrMetricManager
Closing metric reporters for
registry=solr.collection.replacenodetest_coll_notarget.shard1.leader,
tag=1573986814
[junit4] 2> 3120139 INFO (jetty-closer-7012-thread-5) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@e064352{/solr,null,UNAVAILABLE}
[junit4] 2> 3120140 INFO (jetty-closer-7012-thread-5) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 3120142 ERROR
(SUITE-ReplaceNodeNoTargetTest-seed#[792D8D8468C3D3C8]-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> 3120143 INFO
(SUITE-ReplaceNodeNoTargetTest-seed#[792D8D8468C3D3C8]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:47729 47729
[junit4] 2> 3121117 INFO (Thread-7249) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:47729 47729
[junit4] 2> 3121119 WARN (Thread-7249) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 9
/solr/collections/replacenodetest_coll_notarget/terms/shard1
[junit4] 2> 7 /solr/aliases.json
[junit4] 2> 7 /solr/clusterprops.json
[junit4] 2> 6 /solr/security.json
[junit4] 2> 6 /solr/configs/conf1
[junit4] 2> 5
/solr/collections/replacenodetest_coll_notarget/terms/shard2
[junit4] 2> 5
/solr/collections/replacenodetest_coll_notarget/terms/shard4
[junit4] 2> 5
/solr/collections/replacenodetest_coll_notarget/terms/shard3
[junit4] 2> 5
/solr/collections/replacenodetest_coll_notarget/terms/shard5
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 72
/solr/collections/replacenodetest_coll_notarget/state.json
[junit4] 2> 7 /solr/clusterstate.json
[junit4] 2> 3
/solr/overseer_elect/election/72204692102971406-127.0.0.1:41489_solr-n_0000000000
[junit4] 2> 2
/solr/overseer_elect/election/72204692102971407-127.0.0.1:39508_solr-n_0000000002
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 7 /solr/live_nodes
[junit4] 2> 7 /solr/collections
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.ReplaceNodeNoTargetTest_792D8D8468C3D3C8-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {},
docValues:{}, maxPointsInLeafNode=130, maxMBSortInHeap=6.328143312035812,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@618d2db9),
locale=id-ID, timezone=Africa/Conakry
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_152
(64-bit)/cpus=3,threads=1,free=129817680,total=513736704
[junit4] 2> NOTE: All tests run in this JVM: [TestSimDistributedQueue,
TestConfigOverlay, SuggesterTest, DistributedFacetExistsSmallTest,
V2StandaloneTest, SaslZkACLProviderTest, TestJettySolrRunner, UUIDFieldTest,
TestChildDocTransformer, SpellCheckCollatorTest, TestSolr4Spatial,
TestUseDocValuesAsStored, TestRetrieveFieldsOptimizer,
CloneFieldUpdateProcessorFactoryTest, TestRawResponseWriter,
TestCollectionAPIs, TestSlowCompositeReaderWrapper,
HdfsChaosMonkeyNothingIsSafeTest, TimeRoutedAliasUpdateProcessorTest,
RankQueryTest, TestRandomRequestDistribution, CurrencyRangeFacetCloudTest,
BigEndianAscendingWordDeserializerTest, NotRequiredUniqueKeyTest,
TestManagedSynonymFilterFactory, TestDefaultStatsCache, TestStressReorder,
TestLMJelinekMercerSimilarityFactory, TestInPlaceUpdatesDistrib,
TestLegacyField, UpdateRequestProcessorFactoryTest, PrimUtilsTest,
TestDistributedMissingSort, CdcrVersionReplicationTest, TestSort,
TestBulkSchemaConcurrent, TestFieldTypeResource, TestDownShardTolerantSearch,
SystemLogListenerTest, HighlighterMaxOffsetTest, TestConfigSetsAPIZkFailure,
TestManagedSchemaAPI, TestNumericRangeQuery64,
CoreMergeIndexesAdminHandlerTest, TestExceedMaxTermLength,
DistributedTermsComponentTest, SolrMetricManagerTest, CoreSorterTest,
TestHalfAndHalfDocValues, TestXmlQParserPlugin, TestSmileRequest,
TestAtomicUpdateErrorCases, TestHashPartitioner,
TestLegacyNumericRangeQueryBuilder, URLClassifyProcessorTest,
PrimitiveFieldTypeTest, TestCustomSort, JsonLoaderTest,
SolrCoreCheckLockOnStartupTest, XsltUpdateRequestHandlerTest,
TestCorePropertiesReload, TestHttpShardHandlerFactory, TestLRUStatsCache,
TestSolrCloudWithHadoopAuthPlugin, PreAnalyzedUpdateProcessorTest,
HdfsTlogReplayBufferedWhileIndexingTest, TestCloudSearcherWarming,
ConcurrentDeleteAndCreateCollectionTest, SyncSliceTest, DebugComponentTest,
SimpleMLTQParserTest, TestWordDelimiterFilterFactory, SimpleFacetsTest,
TestNoOpRegenerator, HdfsCollectionsAPIDistributedZkTest,
BasicDistributedZk2Test, AtomicUpdatesTest, TestFuzzyAnalyzedSuggestions,
TestSearchPerf, TermVectorComponentTest, CleanupOldIndexTest,
CreateRoutedAliasTest, DistributedSpellCheckComponentTest, TestComponentsName,
SimpleCollectionCreateDeleteTest, TestCloudNestedDocsSort, TestDynamicLoading,
TestCloudDeleteByQuery, TestClusterStateMutator, ShowFileRequestHandlerTest,
RequestHandlersTest, TestSchemaVersionResource, EnumFieldTest,
TestSubQueryTransformerCrossCore, ConjunctionSolrSpellCheckerTest,
TestStreamBody, TestLMDirichletSimilarityFactory, UpdateLogTest, TestMacros,
BlobRepositoryCloudTest, ShufflingReplicaListTransformerTest,
DefaultValueUpdateProcessorTest, FullHLLTest,
HdfsWriteToMultipleCollectionsTest, ClusterStateUpdateTest, TestFastWriter,
DocValuesMultiTest, RegexBytesRefFilterTest, TemplateUpdateProcessorTest,
TestExactSharedStatsCache, TestRandomFaceting, TestSortByMinMaxFunction,
TestConfig, BasicAuthStandaloneTest, RecoveryAfterSoftCommitTest,
CSVRequestHandlerTest, TestDistributedSearch, LegacyCloudClusterPropTest,
SolrIndexMetricsTest, AutoAddReplicasPlanActionTest, TriggerIntegrationTest,
CdcrBootstrapTest, RegexBoostProcessorTest, SolrMetricsIntegrationTest,
TestNodeLostTrigger, TestLargeCluster, TestSolrCloudWithSecureImpersonation,
HealthCheckHandlerTest, LoggingHandlerTest, TestTlogReplica,
TestMinMaxOnMultiValuedField, MetricUtilsTest, TestAnalyzeInfixSuggestions,
HttpPartitionTest, NoCacheHeaderTest, SoftAutoCommitTest,
TestSolrConfigHandler, NodeLostTriggerTest, TestUpdate, TestStandardQParsers,
TestSQLHandler, TestCopyFieldCollectionResource,
FieldAnalysisRequestHandlerTest, TestCloudPseudoReturnFields,
TestFileDictionaryLookup, InfixSuggestersTest, EchoParamsTest,
HdfsNNFailoverTest, TestValueSourceCache, TestStressInPlaceUpdates,
AsyncCallRequestStatusResponseTest, SortByFunctionTest, TestScoreJoinQPNoScore,
MoveReplicaHDFSTest, ExitableDirectoryReaderTest, TestMissingGroups,
DistributedIntervalFacetingTest, SpellCheckComponentTest,
TestLegacyNumericUtils, TestSolrQueryParser,
OverseerCollectionConfigSetProcessorTest, TestRestManager, TestSearcherReuse,
TestDocTermOrds, TestHighFrequencyDictionaryFactory, HdfsRecoveryZkTest,
TestDFRSimilarityFactory, SolrXmlInZkTest, TestRuleBasedAuthorizationPlugin,
OverseerRolesTest, SystemInfoHandlerTest, OverseerTaskQueueTest,
SpellPossibilityIteratorTest, IndexBasedSpellCheckerTest,
DeleteLastCustomShardedReplicaTest, TestPointFields,
UUIDUpdateProcessorFallbackTest, TestFastLRUCache, TestAuthorizationFramework,
BasicFunctionalityTest, TestHashQParserPlugin, PeerSyncTest,
SecurityConfHandlerTest, TestRequestForwarding, TestSchemalessBufferedUpdates,
DistanceFunctionTest, ReplicationFactorTest, ActionThrottleTest,
CollectionsAPIAsyncDistributedZkTest, TestEmbeddedSolrServerConstructors,
TestSegmentSorting, ChaosMonkeySafeLeaderTest, UnloadDistributedZkTest,
OverseerTest, FullSolrCloudDistribCmdsTest, LeaderElectionTest,
TestRandomDVFaceting, TermVectorComponentDistributedTest, ZkControllerTest,
TestReload, QueryElevationComponentTest, ConvertedLegacyTest,
TestFunctionQuery, TestBadConfig, TestExtendedDismaxParser,
CoreAdminHandlerTest, SuggesterTSTTest, TestStressLucene, TestTrie,
SpatialFilterTest, SuggesterWFSTTest, TestCSVLoader, PolyFieldTest,
FieldMutatingUpdateProcessorTest, TestRemoteStreaming, SolrInfoBeanTest,
DisMaxRequestHandlerTest, TestWriterPerf, TestReversedWildcardFilterFactory,
XmlUpdateRequestHandlerTest, TestIndexingPerformance,
FastVectorHighlighterTest, ReturnFieldsTest, QueryParsingTest,
TestPHPSerializedResponseWriter, HighlighterConfigTest, SOLR749Test,
TestQuerySenderListener, UpdateParamsTest, TestSolrIndexConfig,
TestQuerySenderNoQuery, CopyFieldTest, ResponseLogComponentTest,
BadComponentTest, TestStressRecovery, TestMergePolicyConfig,
TestSolrDeletionPolicy2, SampleTest, MinimalSchemaTest,
ExternalFileFieldSortTest, TestPostingsSolrHighlighter, TestLuceneMatchVersion,
TestCharFilters, TestXIncludeConfig, TestIBSimilarityFactory,
TimeZoneUtilsTest, TestFastOutputStream, OpenExchangeRatesOrgProviderTest,
DateMathParserTest, PreAnalyzedFieldTest, TestSystemIdResolver,
SpellingQueryConverterTest, DOMUtilTest, ClusterStateTest, TestLRUCache,
TestUtils, TestDocumentBuilder, SliceStateTest, FileUtilsTest,
CircularListTest, TestRTGBase, SolrTestCaseJ4Test, TestCrossCoreJoin,
TestHighlightDedupGrouping, TestSimpleTrackingShardHandler,
TestLuceneIndexBackCompat, TestEmbeddedSolrServerAdminHandler,
ConnectionReuseTest, AliasIntegrationTest, CloudExitableDirectoryReaderTest,
CollectionStateFormat2Test, CollectionsAPISolrJTest, DeleteReplicaTest,
DistribCursorPagingTest, DistribJoinFromCollectionTest, DistributedQueueTest,
DocValuesNotIndexedTest, LIRRollingUpdatesTest,
LeaderFailureAfterFreshStartTest, MultiThreadedOCPTest,
OverseerModifyCollectionTest, ReplaceNodeNoTargetTest]
[junit4] Completed [541/776 (2!)] on J1 in 11.91s, 1 test, 1 failure <<<
FAILURES!
[...truncated 49318 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
