Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/8858/
Java: 64bit/jdk-14 -XX:+UseCompressedOops -XX:+UnlockExperimentalVMOptions
-XX:+UseShenandoahGC
1 tests failed.
FAILED:
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest.testScheduledTrigger
Error Message:
ScheduledTrigger did not fire in time
Stack Trace:
java.lang.AssertionError: ScheduledTrigger did not fire in time
at
__randomizedtesting.SeedInfo.seed([CBD14AC8EA7AC06B:58CA02BAB4879B5F]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.assertTrue(Assert.java:41)
at
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest.testScheduledTrigger(ScheduledTriggerIntegrationTest.java:120)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
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:370)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
at java.base/java.lang.Thread.run(Thread.java:832)
Build Log:
[...truncated 14926 lines...]
[junit4] Suite:
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest
[junit4] 2> 1517951 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[CBD14AC8EA7AC06B]-worker) [ ]
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to
test-framework derived value of
'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\server\solr\configsets\_default\conf'
[junit4] 2> 1517953 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[CBD14AC8EA7AC06B]-worker) [ ]
o.a.s.SolrTestCaseJ4 Created dataDir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_CBD14AC8EA7AC06B-001\data-dir-154-001
[junit4] 2> 1517953 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[CBD14AC8EA7AC06B]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1517955 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[CBD14AC8EA7AC06B]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0,
clientAuth=0.0/0.0)
[junit4] 2> 1517955 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[CBD14AC8EA7AC06B]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1517956 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testScheduledTrigger
[junit4] 2> 1517958 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_CBD14AC8EA7AC06B-001\tempDir-001
[junit4] 2> 1517958 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1517958 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 1517958 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1518058 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.ZkTestServer start zk server on port: 64413
[junit4] 2> 1518058 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:64413
[junit4] 2> 1518058 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:64413
[junit4] 2> 1518058 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 64413
[junit4] 2> 1518058 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1518063 INFO (zkConnectionManagerCallback-14410-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1518064 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1518092 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1518093 INFO (zkConnectionManagerCallback-14412-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1518093 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1518095 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1518096 INFO (zkConnectionManagerCallback-14414-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1518096 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1518197 INFO (jetty-launcher-14415-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1518197 INFO (jetty-launcher-14415-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1518197 INFO (jetty-launcher-14415-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1518197 INFO (jetty-launcher-14415-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1518197 INFO (jetty-launcher-14415-thread-1) [ ]
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git:
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 14+36
[junit4] 2> 1518197 INFO (jetty-launcher-14415-thread-2) [ ]
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git:
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 14+36
[junit4] 2> 1518198 INFO (jetty-launcher-14415-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1518198 INFO (jetty-launcher-14415-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1518198 INFO (jetty-launcher-14415-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1518198 INFO (jetty-launcher-14415-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1518198 INFO (jetty-launcher-14415-thread-2) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1518198 INFO (jetty-launcher-14415-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1518198 INFO (jetty-launcher-14415-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7a94c4a6{/solr,null,AVAILABLE}
[junit4] 2> 1518198 INFO (jetty-launcher-14415-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@4d759895{/solr,null,AVAILABLE}
[junit4] 2> 1518199 INFO (jetty-launcher-14415-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@6c283d2a{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:64436}
[junit4] 2> 1518199 INFO (jetty-launcher-14415-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@52d63bb4{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:64435}
[junit4] 2> 1518199 INFO (jetty-launcher-14415-thread-2) [ ]
o.e.j.s.Server Started @1470648ms
[junit4] 2> 1518199 INFO (jetty-launcher-14415-thread-1) [ ]
o.e.j.s.Server Started @1470648ms
[junit4] 2> 1518199 INFO (jetty-launcher-14415-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=64436}
[junit4] 2> 1518199 INFO (jetty-launcher-14415-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=64435}
[junit4] 2> 1518200 ERROR (jetty-launcher-14415-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1518200 ERROR (jetty-launcher-14415-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1518200 INFO (jetty-launcher-14415-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1518200 INFO (jetty-launcher-14415-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1518200 INFO (jetty-launcher-14415-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
9.0.0
[junit4] 2> 1518200 INFO (jetty-launcher-14415-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
9.0.0
[junit4] 2> 1518200 INFO (jetty-launcher-14415-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1518200 INFO (jetty-launcher-14415-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1518200 INFO (jetty-launcher-14415-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
[junit4] 2> 1518200 INFO (jetty-launcher-14415-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
[junit4] 2> 1518200 INFO (jetty-launcher-14415-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-05-20T20:53:22.283154600Z
[junit4] 2> 1518200 INFO (jetty-launcher-14415-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-05-20T20:53:22.283154600Z
[junit4] 2> 1518200 INFO (jetty-launcher-14415-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1518201 INFO (jetty-launcher-14415-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1518202 INFO (zkConnectionManagerCallback-14418-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1518202 INFO (jetty-launcher-14415-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1518202 INFO (zkConnectionManagerCallback-14419-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1518202 INFO (jetty-launcher-14415-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1518203 INFO (jetty-launcher-14415-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1518203 INFO (jetty-launcher-14415-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1518305 INFO (jetty-launcher-14415-thread-2) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1518306 WARN (jetty-launcher-14415-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@18f9f146[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1518306 WARN (jetty-launcher-14415-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@18f9f146[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1518309 WARN (jetty-launcher-14415-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@5811339e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1518309 WARN (jetty-launcher-14415-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@5811339e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1518310 INFO (jetty-launcher-14415-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:64413/solr
[junit4] 2> 1518310 INFO (jetty-launcher-14415-thread-2)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1518312 INFO (zkConnectionManagerCallback-14430-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1518312 INFO (jetty-launcher-14415-thread-2)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1518382 INFO (jetty-launcher-14415-thread-2)
[n:127.0.0.1:64436_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:64436_solr
[junit4] 2> 1518383 INFO (jetty-launcher-14415-thread-2)
[n:127.0.0.1:64436_solr ] o.a.s.c.Overseer Overseer
(id=72076850644516869-127.0.0.1:64436_solr-n_0000000000) starting
[junit4] 2> 1518387 INFO (jetty-launcher-14415-thread-2)
[n:127.0.0.1:64436_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:64436_solr
[junit4] 2> 1518387 INFO
(OverseerStateUpdate-72076850644516869-127.0.0.1:64436_solr-n_0000000000)
[n:127.0.0.1:64436_solr ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:64436_solr
[junit4] 2> 1518387 DEBUG
(OverseerAutoScalingTriggerThread-72076850644516869-127.0.0.1:64436_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and
.scheduled_maintenance triggers
[junit4] 2> 1518388 INFO
(OverseerStateUpdate-72076850644516869-127.0.0.1:64436_solr-n_0000000000)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1518388 DEBUG
(OverseerAutoScalingTriggerThread-72076850644516869-127.0.0.1:64436_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with
znode version 1
[junit4] 2> 1518388 DEBUG
(OverseerAutoScalingTriggerThread-72076850644516869-127.0.0.1:64436_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1,
lastZnodeVersion 0
[junit4] 2> 1518388 DEBUG
(OverseerAutoScalingTriggerThread-72076850644516869-127.0.0.1:64436_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 1
[junit4] 2> 1518389 INFO (jetty-launcher-14415-thread-2)
[n:127.0.0.1:64436_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1518389 WARN (jetty-launcher-14415-thread-2)
[n:127.0.0.1:64436_solr ] o.a.s.c.CoreContainer Not all security plugins
configured! authentication=disabled authorization=disabled. Solr is only as
secure as you make it. Consider configuring authentication/authorization before
exposing Solr to users internal or external. See
https://s.apache.org/solrsecurity for more info
[junit4] 2> 1518392 DEBUG
(OverseerAutoScalingTriggerThread-72076850644516869-127.0.0.1:64436_solr-n_0000000000)
[ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial
livenodes: [127.0.0.1:64436_solr]
[junit4] 2> 1518392 DEBUG
(OverseerAutoScalingTriggerThread-72076850644516869-127.0.0.1:64436_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1518392 DEBUG (ScheduledTrigger-14435-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 1 and last live nodes: 1
[junit4] 2> 1518392 DEBUG
(OverseerAutoScalingTriggerThread-72076850644516869-127.0.0.1:64436_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1,
lastZnodeVersion 1
[junit4] 2> 1518403 INFO (jetty-launcher-14415-thread-1) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1518403 WARN (jetty-launcher-14415-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@47ff6d72[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1518403 WARN (jetty-launcher-14415-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@47ff6d72[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1518406 WARN (jetty-launcher-14415-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@58492ef4[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1518406 WARN (jetty-launcher-14415-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@58492ef4[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1518407 INFO (jetty-launcher-14415-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:64413/solr
[junit4] 2> 1518408 INFO (jetty-launcher-14415-thread-1)
[n:127.0.0.1:64435_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1518409 INFO (zkConnectionManagerCallback-14449-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1518409 INFO (jetty-launcher-14415-thread-1)
[n:127.0.0.1:64435_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1518412 INFO (jetty-launcher-14415-thread-2)
[n:127.0.0.1:64436_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1518413 INFO (jetty-launcher-14415-thread-1)
[n:127.0.0.1:64435_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1518417 INFO (jetty-launcher-14415-thread-1)
[n:127.0.0.1:64435_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:64435_solr as DOWN
[junit4] 2> 1518418 INFO (jetty-launcher-14415-thread-1)
[n:127.0.0.1:64435_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 1000 transient cores
[junit4] 2> 1518418 INFO (jetty-launcher-14415-thread-1)
[n:127.0.0.1:64435_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:64435_solr
[junit4] 2> 1518419 INFO (zkCallback-14429-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1518419 INFO (zkCallback-14448-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1518420 INFO (jetty-launcher-14415-thread-1)
[n:127.0.0.1:64435_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1518420 WARN (jetty-launcher-14415-thread-1)
[n:127.0.0.1:64435_solr ] o.a.s.c.CoreContainer Not all security plugins
configured! authentication=disabled authorization=disabled. Solr is only as
secure as you make it. Consider configuring authentication/authorization before
exposing Solr to users internal or external. See
https://s.apache.org/solrsecurity for more info
[junit4] 2> 1518432 INFO (jetty-launcher-14415-thread-2)
[n:127.0.0.1:64436_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_64436.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@f1ebfcf
[junit4] 2> 1518437 INFO (jetty-launcher-14415-thread-2)
[n:127.0.0.1:64436_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_64436.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@f1ebfcf
[junit4] 2> 1518437 INFO (jetty-launcher-14415-thread-2)
[n:127.0.0.1:64436_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_64436.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@f1ebfcf
[junit4] 2> 1518438 INFO (jetty-launcher-14415-thread-2)
[n:127.0.0.1:64436_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_CBD14AC8EA7AC06B-001\tempDir-001\node2\.
[junit4] 2> 1518443 INFO (jetty-launcher-14415-thread-1)
[n:127.0.0.1:64435_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1518460 INFO (jetty-launcher-14415-thread-1)
[n:127.0.0.1:64435_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_64435.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@f1ebfcf
[junit4] 2> 1518466 INFO (jetty-launcher-14415-thread-1)
[n:127.0.0.1:64435_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_64435.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@f1ebfcf
[junit4] 2> 1518466 INFO (jetty-launcher-14415-thread-1)
[n:127.0.0.1:64435_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_64435.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@f1ebfcf
[junit4] 2> 1518467 INFO (jetty-launcher-14415-thread-1)
[n:127.0.0.1:64435_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_CBD14AC8EA7AC06B-001\tempDir-001\node1\.
[junit4] 2> 1518477 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
[junit4] 2> 1518478 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1518480 INFO (zkConnectionManagerCallback-14466-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1518480 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1518481 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1518482 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at
127.0.0.1:64413/solr ready
[junit4] 2> 1518487 INFO (qtp1544670790-21902) [n:127.0.0.1:64435_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1518492 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=2
[junit4] 2> 1518493 INFO (qtp1659883271-21903) [n:127.0.0.1:64436_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 1000
transient cores
[junit4] 2> 1518495 INFO (qtp1659883271-21903) [n:127.0.0.1:64436_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=2
[junit4] 2> 1518495 DEBUG (qtp1544670790-21904) [n:127.0.0.1:64435_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1518496 INFO (qtp1544670790-21904) [n:127.0.0.1:64435_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=7
[junit4] 2> 1518496 DEBUG (zkCallback-14429-thread-1) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
2
[junit4] 2> 1518496 DEBUG
(OverseerAutoScalingTriggerThread-72076850644516869-127.0.0.1:64436_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 2
[junit4] 2> 1518497 INFO (qtp1659883271-21907) [n:127.0.0.1:64436_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
pullReplicas=0&maxShardsPerNode=5&name=testScheduledTrigger&nrtReplicas=3&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 1518498 DEBUG
(OverseerAutoScalingTriggerThread-72076850644516869-127.0.0.1:64436_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1518499 DEBUG
(OverseerAutoScalingTriggerThread-72076850644516869-127.0.0.1:64436_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2,
lastZnodeVersion 2
[junit4] 2> 1518500 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
testScheduledTrigger
[junit4] 2> 1518500 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/managed-schema to
/configs/testScheduledTrigger.AUTOCREATED/managed-schema
[junit4] 2> 1518502 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/protwords.txt to
/configs/testScheduledTrigger.AUTOCREATED/protwords.txt
[junit4] 2> 1518503 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_it.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/contractions_it.txt
[junit4] 2> 1518505 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_ca.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/contractions_ca.txt
[junit4] 2> 1518506 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stemdict_nl.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stemdict_nl.txt
[junit4] 2> 1518507 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_hy.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_hy.txt
[junit4] 2> 1518509 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_no.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_no.txt
[junit4] 2> 1518510 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_id.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_id.txt
[junit4] 2> 1518512 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_et.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_et.txt
[junit4] 2> 1518513 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_da.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_da.txt
[junit4] 2> 1518514 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ga.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_ga.txt
[junit4] 2> 1518515 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_hi.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_hi.txt
[junit4] 2> 1518517 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ja.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_ja.txt
[junit4] 2> 1518518 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_pt.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_pt.txt
[junit4] 2> 1518519 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_hu.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_hu.txt
[junit4] 2> 1518521 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_el.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_el.txt
[junit4] 2> 1518523 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ru.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_ru.txt
[junit4] 2> 1518524 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_tr.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_tr.txt
[junit4] 2> 1518526 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ar.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_ar.txt
[junit4] 2> 1518527 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/userdict_ja.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/userdict_ja.txt
[junit4] 2> 1518528 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_eu.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_eu.txt
[junit4] 2> 1518530 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_it.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_it.txt
[junit4] 2> 1518531 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_cz.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_cz.txt
[junit4] 2> 1518532 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stoptags_ja.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stoptags_ja.txt
[junit4] 2> 1518534 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_fr.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/contractions_fr.txt
[junit4] 2> 1518535 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_de.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_de.txt
[junit4] 2> 1518537 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_fa.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_fa.txt
[junit4] 2> 1518538 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_ga.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/contractions_ga.txt
[junit4] 2> 1518539 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ca.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_ca.txt
[junit4] 2> 1518540 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_nl.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_nl.txt
[junit4] 2> 1518542 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_bg.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_bg.txt
[junit4] 2> 1518543 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_en.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_en.txt
[junit4] 2> 1518545 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_es.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_es.txt
[junit4] 2> 1518546 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_lv.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_lv.txt
[junit4] 2> 1518547 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ro.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_ro.txt
[junit4] 2> 1518547 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_th.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_th.txt
[junit4] 2> 1518547 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_fr.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_fr.txt
[junit4] 2> 1518551 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_sv.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_sv.txt
[junit4] 2> 1518553 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_fi.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_fi.txt
[junit4] 2> 1518554 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/hyphenations_ga.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/hyphenations_ga.txt
[junit4] 2> 1518555 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_gl.txt to
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_gl.txt
[junit4] 2> 1518556 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/solrconfig.xml to
/configs/testScheduledTrigger.AUTOCREATED/solrconfig.xml
[junit4] 2> 1518558 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/synonyms.txt to
/configs/testScheduledTrigger.AUTOCREATED/synonyms.txt
[junit4] 2> 1518559 INFO
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/stopwords.txt to
/configs/testScheduledTrigger.AUTOCREATED/stopwords.txt
[junit4] 2> 1518660 WARN
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.a.c.CreateCollectionCmd Specified number
of replicas of 3 on collection testScheduledTrigger is higher than the number
of Solr instances currently live or live and part of your createNodeSet(2).
It's unusual to run two replica of the same slice on the same Solr-instance.
[junit4] 2> 1518661 DEBUG
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.s.c.a.PolicyHelper Creating a new session
[junit4] 2> 1518663 INFO (qtp1659883271-21903) [n:127.0.0.1:64436_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=2
[junit4] 2> 1518666 INFO (qtp1544670790-21902) [n:127.0.0.1:64435_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=2
[junit4] 2> 1518666 DEBUG
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.s.c.a.PolicyHelper New session created
[junit4] 2> 1518669 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=2
[junit4] 2> 1518671 INFO (qtp1544670790-21906) [n:127.0.0.1:64435_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=2
[junit4] 2> 1518672 DEBUG
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.s.c.a.PolicyHelper returnSession,
curr-time 293833222 sessionWrapper.createTime 293833216834800,
this.sessionWrapper.createTime 293833216834800
[junit4] 2> 1518675 INFO
(OverseerStateUpdate-72076850644516869-127.0.0.1:64436_solr-n_0000000000)
[n:127.0.0.1:64436_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testScheduledTrigger",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testScheduledTrigger_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:64435/solr";,
[junit4] 2> "node_name":"127.0.0.1:64435_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1518677 INFO
(OverseerStateUpdate-72076850644516869-127.0.0.1:64436_solr-n_0000000000)
[n:127.0.0.1:64436_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testScheduledTrigger",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testScheduledTrigger_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:64436/solr";,
[junit4] 2> "node_name":"127.0.0.1:64436_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1518679 INFO
(OverseerStateUpdate-72076850644516869-127.0.0.1:64436_solr-n_0000000000)
[n:127.0.0.1:64436_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testScheduledTrigger",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testScheduledTrigger_shard1_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:64436/solr";,
[junit4] 2> "node_name":"127.0.0.1:64436_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1518874 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core
create command
qt=/admin/cores&coreNodeName=core_node3&collection.configName=testScheduledTrigger.AUTOCREATED&newCollection=true&name=testScheduledTrigger_shard1_replica_n1&action=CREATE&numShards=1&collection=testScheduledTrigger&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1518874 INFO (qtp1659883271-21901) [n:127.0.0.1:64436_solr
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.h.a.CoreAdminOperation core
create command
qt=/admin/cores&coreNodeName=core_node5&collection.configName=testScheduledTrigger.AUTOCREATED&newCollection=true&name=testScheduledTrigger_shard1_replica_n2&action=CREATE&numShards=1&collection=testScheduledTrigger&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1518874 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.h.a.CoreAdminOperation core
create command
qt=/admin/cores&coreNodeName=core_node6&collection.configName=testScheduledTrigger.AUTOCREATED&newCollection=true&name=testScheduledTrigger_shard1_replica_n4&action=CREATE&numShards=1&collection=testScheduledTrigger&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1518890 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 9.0.0
[junit4] 2> 1518890 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 9.0.0
[junit4] 2> 1518890 INFO (qtp1659883271-21901) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 9.0.0
[junit4] 2> 1518905 INFO (qtp1659883271-21901) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1518907 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1518907 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1519284 INFO (qtp1659883271-21901) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.s.IndexSchema Loaded schema
default-config/1.6 with uniqueid field id
[junit4] 2> 1519284 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.s.IndexSchema Loaded schema
default-config/1.6 with uniqueid field id
[junit4] 2> 1519284 INFO (qtp1659883271-21901) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.CoreContainer Creating
SolrCore 'testScheduledTrigger_shard1_replica_n2' using configuration from
configset testScheduledTrigger.AUTOCREATED, trusted=true
[junit4] 2> 1519284 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.c.CoreContainer Creating
SolrCore 'testScheduledTrigger_shard1_replica_n4' using configuration from
configset testScheduledTrigger.AUTOCREATED, trusted=true
[junit4] 2> 1519285 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_64436.solr.core.testScheduledTrigger.shard1.replica_n4'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n4') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@f1ebfcf
[junit4] 2> 1519285 INFO (qtp1659883271-21901) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_64436.solr.core.testScheduledTrigger.shard1.replica_n2'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n2') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@f1ebfcf
[junit4] 2> 1519285 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.c.SolrCore
[[testScheduledTrigger_shard1_replica_n4] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_CBD14AC8EA7AC06B-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n4],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_CBD14AC8EA7AC06B-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n4\data\]
[junit4] 2> 1519285 INFO (qtp1659883271-21901) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.SolrCore
[[testScheduledTrigger_shard1_replica_n2] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_CBD14AC8EA7AC06B-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n2],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_CBD14AC8EA7AC06B-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n2\data\]
[junit4] 2> 1519289 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema
default-config/1.6 with uniqueid field id
[junit4] 2> 1519289 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating
SolrCore 'testScheduledTrigger_shard1_replica_n1' using configuration from
configset testScheduledTrigger.AUTOCREATED, trusted=true
[junit4] 2> 1519289 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_64435.solr.core.testScheduledTrigger.shard1.replica_n1'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n1') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@f1ebfcf
[junit4] 2> 1519290 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.SolrCore
[[testScheduledTrigger_shard1_replica_n1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_CBD14AC8EA7AC06B-001\tempDir-001\node1\.\testScheduledTrigger_shard1_replica_n1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_CBD14AC8EA7AC06B-001\tempDir-001\node1\.\testScheduledTrigger_shard1_replica_n1\data\]
[junit4] 2> 1519359 DEBUG (ScheduledTrigger-14435-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 1
[junit4] 2> 1519472 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using
UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1519472 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1519474 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard
AutoCommit: if uncommitted for 15000ms;
[junit4] 2> 1519474 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1519474 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.u.UpdateHandler Using
UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1519474 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1519474 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase:
/configs/testScheduledTrigger.AUTOCREATED
[junit4] 2> 1519474 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage
Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/testScheduledTrigger.AUTOCREATED
[junit4] 2> 1519474 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Creating
ZooKeeper watch for the managed schema at
/configs/testScheduledTrigger.AUTOCREATED/managed-schema
[junit4] 2> 1519479 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Current
schema version 0 is already the latest
[junit4] 2> 1519479 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1519479 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.s.DirectSolrSpellChecker init:
{name=default, field=_text_, classname=solr.DirectSolrSpellChecker,
distanceMeasure=internal, accuracy=0.5, maxEdits=2, minPrefix=1,
maxInspections=5, minQueryLength=4, maxQueryFrequency=0.01}
[junit4] 2> 1519480 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.u.CommitTracker Hard
AutoCommit: if uncommitted for 15000ms;
[junit4] 2> 1519480 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1519480 INFO (qtp1659883271-21901) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.u.UpdateHandler Using
UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1519480 INFO (qtp1659883271-21901) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1519480 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000 ms
[junit4] 2> 1519480 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1667244232344076288
[junit4] 2> 1519483 INFO (qtp1659883271-21901) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.u.CommitTracker Hard
AutoCommit: if uncommitted for 15000ms;
[junit4] 2> 1519483 INFO (qtp1659883271-21901) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1519483 INFO
(searcherExecutor-14472-thread-1-processing-n:127.0.0.1:64435_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:64435_solr c:testScheduledTrigger s:shard1
r:core_node3 x:testScheduledTrigger_shard1_replica_n1 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1519483 INFO
(searcherExecutor-14472-thread-1-processing-n:127.0.0.1:64435_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:64435_solr c:testScheduledTrigger s:shard1
r:core_node3 x:testScheduledTrigger_shard1_replica_n1 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1519484 INFO
(searcherExecutor-14472-thread-1-processing-n:127.0.0.1:64435_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:64435_solr c:testScheduledTrigger s:shard1
r:core_node3 x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.SolrCore
[testScheduledTrigger_shard1_replica_n1] Registered new searcher autowarm
time: 0 ms: Collection: 'testScheduledTrigger'
[junit4] 2> 1519486 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase:
/configs/testScheduledTrigger.AUTOCREATED
[junit4] 2> 1519486 INFO (qtp1659883271-21901) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase:
/configs/testScheduledTrigger.AUTOCREATED
[junit4] 2> 1519486 INFO (qtp1659883271-21901) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.r.ManagedResourceStorage
Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/testScheduledTrigger.AUTOCREATED
[junit4] 2> 1519487 INFO (qtp1659883271-21901) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.s.ZkIndexSchemaReader Creating
ZooKeeper watch for the managed schema at
/configs/testScheduledTrigger.AUTOCREATED/managed-schema
[junit4] 2> 1519487 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.r.ManagedResourceStorage
Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/testScheduledTrigger.AUTOCREATED
[junit4] 2> 1519487 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.s.ZkIndexSchemaReader Creating
ZooKeeper watch for the managed schema at
/configs/testScheduledTrigger.AUTOCREATED/managed-schema
[junit4] 2> 1519488 INFO (qtp1659883271-21901) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.s.ZkIndexSchemaReader Current
schema version 0 is already the latest
[junit4] 2> 1519488 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.s.ZkIndexSchemaReader Current
schema version 0 is already the latest
[junit4] 2> 1519488 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1519488 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.s.DirectSolrSpellChecker init:
{name=default, field=_text_, classname=solr.DirectSolrSpellChecker,
distanceMeasure=internal, accuracy=0.5, maxEdits=2, minPrefix=1,
maxInspections=5, minQueryLength=4, maxQueryFrequency=0.01}
[junit4] 2> 1519488 INFO (qtp1659883271-21901) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1519488 INFO (qtp1659883271-21901) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.s.DirectSolrSpellChecker init:
{name=default, field=_text_, classname=solr.DirectSolrSpellChecker,
distanceMeasure=internal, accuracy=0.5, maxEdits=2, minPrefix=1,
maxInspections=5, minQueryLength=4, maxQueryFrequency=0.01}
[junit4] 2> 1519490 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful
update of terms at /collections/testScheduledTrigger/terms/shard1 to
Terms{values={core_node3=0}, version=0}
[junit4] 2> 1519490 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created
/collections/testScheduledTrigger/leaders/shard1
[junit4] 2> 1519490 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000 ms
[junit4] 2> 1519490 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1667244232354562048
[junit4] 2> 1519490 INFO (qtp1659883271-21901) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000 ms
[junit4] 2> 1519490 INFO (qtp1659883271-21901) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1667244232354562048
[junit4] 2> 1519492 INFO
(searcherExecutor-14470-thread-1-processing-n:127.0.0.1:64436_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:64436_solr c:testScheduledTrigger s:shard1
r:core_node6 x:testScheduledTrigger_shard1_replica_n4 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1519492 INFO
(searcherExecutor-14469-thread-1-processing-n:127.0.0.1:64436_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:64436_solr c:testScheduledTrigger s:shard1
r:core_node5 x:testScheduledTrigger_shard1_replica_n2 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1519492 INFO
(searcherExecutor-14470-thread-1-processing-n:127.0.0.1:64436_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:64436_solr c:testScheduledTrigger s:shard1
r:core_node6 x:testScheduledTrigger_shard1_replica_n4 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1519492 INFO
(searcherExecutor-14469-thread-1-processing-n:127.0.0.1:64436_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:64436_solr c:testScheduledTrigger s:shard1
r:core_node5 x:testScheduledTrigger_shard1_replica_n2 ]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1519493 INFO
(searcherExecutor-14469-thread-1-processing-n:127.0.0.1:64436_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:64436_solr c:testScheduledTrigger s:shard1
r:core_node5 x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.SolrCore
[testScheduledTrigger_shard1_replica_n2] Registered new searcher autowarm
time: 0 ms: Collection: 'testScheduledTrigger'
[junit4] 2> 1519493 INFO
(searcherExecutor-14470-thread-1-processing-n:127.0.0.1:64436_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:64436_solr c:testScheduledTrigger s:shard1
r:core_node6 x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.c.SolrCore
[testScheduledTrigger_shard1_replica_n4] Registered new searcher autowarm
time: 0 ms: Collection: 'testScheduledTrigger'
[junit4] 2> 1519495 INFO (qtp1659883271-21901) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.ZkShardTerms Successful
update of terms at /collections/testScheduledTrigger/terms/shard1 to
Terms{values={core_node3=0, core_node5=0}, version=1}
[junit4] 2> 1519495 INFO (qtp1659883271-21901) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ]
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created
/collections/testScheduledTrigger/leaders/shard1
[junit4] 2> 1519496 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.c.ZkShardTerms Successful
update of terms at /collections/testScheduledTrigger/terms/shard1 to
Terms{values={core_node6=0, core_node3=0, core_node5=0}, version=2}
[junit4] 2> 1519496 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ]
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created
/collections/testScheduledTrigger/leaders/shard1
[junit4] 2> 1519496 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext
Waiting until we see more replicas up for shard shard1: total=3 found=1
timeoute in=9999ms
[junit4] 2> 1519984 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext
Enough replicas found to continue.
[junit4] 2> 1519984 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I
may be the new leader - try and sync
[junit4] 2> 1519984 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas
to http://127.0.0.1:64435/solr/testScheduledTrigger_shard1_replica_n1/
[junit4] 2> 1519984 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.PeerSync PeerSync:
core=testScheduledTrigger_shard1_replica_n1 url=http://127.0.0.1:64435/solr
START
replicas=[http://127.0.0.1:64436/solr/testScheduledTrigger_shard1_replica_n2/,
http://127.0.0.1:64436/solr/testScheduledTrigger_shard1_replica_n4/]
nUpdates=100
[junit4] 2> 1519985 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.PeerSync PeerSync:
core=testScheduledTrigger_shard1_replica_n1 url=http://127.0.0.1:64435/solr
DONE. We have no versions. sync failed.
[junit4] 2> 1519986 INFO (qtp1659883271-21903) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.c.S.Request
[testScheduledTrigger_shard1_replica_n4] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 1519986 INFO (qtp1659883271-21903) [n:127.0.0.1:64436_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.S.Request
[testScheduledTrigger_shard1_replica_n2] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 1519986 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.SyncStrategy Leader's
attempt to sync with shard failed, moving to the next candidate
[junit4] 2> 1519986 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext
We failed sync, but we have no versions - we can't sync in that case - we were
active before, so become leader anyway
[junit4] 2> 1519986 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
/collections/testScheduledTrigger/leaders/shard1/leader after winning as
/collections/testScheduledTrigger/leader_elect/shard1/election/72076850644516870-core_node3-n_0000000000
[junit4] 2> 1519988 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I
am the new leader:
http://127.0.0.1:64435/solr/testScheduledTrigger_shard1_replica_n1/ shard1
[junit4] 2> 1520086 INFO (zkCallback-14448-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testScheduledTrigger/state.json] for collection
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1520086 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.ZkController I am the
leader, no recovery necessary
[junit4] 2> 1520091 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=testScheduledTrigger.AUTOCREATED&newCollection=true&name=testScheduledTrigger_shard1_replica_n1&action=CREATE&numShards=1&collection=testScheduledTrigger&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1260
[junit4] 2> 1520185 INFO (zkCallback-14448-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testScheduledTrigger/state.json] for collection
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1520185 INFO (zkCallback-14448-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testScheduledTrigger/state.json] for collection
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1520347 DEBUG (ScheduledTrigger-14435-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 1520468 INFO (qtp1659883271-21901) [n:127.0.0.1:64436_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node5&collection.configName=testScheduledTrigger.AUTOCREATED&newCollection=true&name=testScheduledTrigger_shard1_replica_n2&action=CREATE&numShards=1&collection=testScheduledTrigger&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1651
[junit4] 2> 1520468 INFO (qtp1659883271-21905) [n:127.0.0.1:64436_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node6&collection.configName=testScheduledTrigger.AUTOCREATED&newCollection=true&name=testScheduledTrigger_shard1_replica_n4&action=CREATE&numShards=1&collection=testScheduledTrigger&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1651
[junit4] 2> 1520468 DEBUG
(OverseerThreadFactory-14437-thread-1-processing-n:127.0.0.1:64436_solr)
[n:127.0.0.1:64436_solr ] o.a.s.c.s.c.a.PolicyHelper session set to NULL
[junit4] 2> 1520470 INFO (qtp1659883271-21907) [n:127.0.0.1:64436_solr
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at
most 45 seconds. Check all shard replicas
[junit4] 2> 1520564 INFO (zkCallback-14429-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testScheduledTrigger/state.json] for collection
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1520564 INFO (zkCallback-14429-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testScheduledTrigger/state.json] for collection
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1520564 INFO (zkCallback-14448-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testScheduledTrigger/state.json] for collection
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1520564 INFO (zkCallback-14448-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testScheduledTrigger/state.json] for collection
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1520565 INFO (qtp1659883271-21907) [n:127.0.0.1:64436_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={pullReplicas=0&maxShardsPerNode=5&name=testScheduledTrigger&nrtReplicas=3&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2}
status=0 QTime=2142
[junit4] 2> 1520565 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection:
testScheduledTrigger
[junit4] 2> 1520568 INFO (qtp1659883271-21970) [n:127.0.0.1:64436_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.testScheduledTrigger.shard1.replica_n2:INDEX.sizeInBytes&key=solr.core.testScheduledTrigger.shard1.replica_n4:INDEX.sizeInBytes}
status=0 QTime=0
[junit4] 2> 1520570 INFO (qtp1659883271-21903) [n:127.0.0.1:64436_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=1
[junit4] 2> 1520570 INFO (qtp1544670790-21906) [n:127.0.0.1:64435_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.testScheduledTrigger.shard1.replica_n1:INDEX.sizeInBytes}
status=0 QTime=0
[junit4] 2> 1520571 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=1
[junit4] 2> 1520572 DEBUG (qtp1544670790-21902) [n:127.0.0.1:64435_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1520572 INFO (qtp1544670790-21902) [n:127.0.0.1:64435_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=5
[junit4] 2> 1520572 DEBUG (zkCallback-14429-thread-3) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
3
[junit4] 2> 1520573 DEBUG
(OverseerAutoScalingTriggerThread-72076850644516869-127.0.0.1:64436_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 3
[junit4] 2> 1520573 DEBUG
(OverseerAutoScalingTriggerThread-72076850644516869-127.0.0.1:64436_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1520573 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding
port=0)
[junit4] 2> 1520573 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number
2 ...
[junit4] 2> 1520573 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.e.j.s.Server jetty-9.4.27.v20200227; built:
2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm
14+36
[junit4] 2> 1520573 DEBUG
(OverseerAutoScalingTriggerThread-72076850644516869-127.0.0.1:64436_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3,
lastZnodeVersion 3
[junit4] 2> 1520573 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1520573 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1520574 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1520574 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@4318af13{/solr,null,AVAILABLE}
[junit4] 2> 1520575 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.e.j.s.AbstractConnector Started ServerConnector@506966a3{HTTP/1.1,
(http/1.1, h2c)}{127.0.0.1:64483}
[junit4] 2> 1520575 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.e.j.s.Server Started @1473109ms
[junit4] 2> 1520575 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=64483}
[junit4] 2> 1520575 ERROR
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging
may be missing or incomplete.
[junit4] 2> 1520575 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1520576 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™
version 9.0.0
[junit4] 2> 1520576 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on
port null
[junit4] 2> 1520576 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
[junit4] 2> 1520576 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-05-20T20:53:24.659295600Z
[junit4] 2> 1520576 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1520578 INFO (zkConnectionManagerCallback-14486-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1520578 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1520579 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1520681 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1520682 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.e.j.u.s.S.config Trusting all certificates configured for
Client@2564b2d5[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1520682 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm
configured for Client@2564b2d5[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1520685 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.e.j.u.s.S.config Trusting all certificates configured for
Client@37f3533e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1520685 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm
configured for Client@37f3533e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1520685 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:64413/solr
[junit4] 2> 1520686 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[n:127.0.0.1:64483_solr ] o.a.s.c.c.ConnectionManager Waiting for client
to connect to ZooKeeper
[junit4] 2> 1520688 INFO (zkConnectionManagerCallback-14497-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1520688 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[n:127.0.0.1:64483_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1520692 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[n:127.0.0.1:64483_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 1520694 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[n:127.0.0.1:64483_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:64483_solr as DOWN
[junit4] 2> 1520695 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[n:127.0.0.1:64483_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 1000 transient cores
[junit4] 2> 1520695 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[n:127.0.0.1:64483_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:64483_solr
[junit4] 2> 1520697 INFO (zkCallback-14448-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1520697 INFO (zkCallback-14429-thread-3) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1520697 INFO (zkCallback-14465-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1520697 INFO (zkCallback-14496-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1520698 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[n:127.0.0.1:64483_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1520698 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[n:127.0.0.1:64483_solr ] o.a.s.c.CoreContainer Not all security plugins
configured! authentication=disabled authorization=disabled. Solr is only as
secure as you make it. Consider configuring authentication/authorization before
exposing Solr to users internal or external. See
https://s.apache.org/solrsecurity for more info
[junit4] 2> 1520720 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[n:127.0.0.1:64483_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1520738 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[n:127.0.0.1:64483_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_64483.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@f1ebfcf
[junit4] 2> 1520745 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[n:127.0.0.1:64483_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_64483.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@f1ebfcf
[junit4] 2> 1520745 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[n:127.0.0.1:64483_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_64483.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@f1ebfcf
[junit4] 2> 1520746 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[n:127.0.0.1:64483_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_CBD14AC8EA7AC06B-001\tempDir-001\node3\.
[junit4] 2> 1520756 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=3
[junit4] 2> 1520758 INFO (qtp1544670790-21906) [n:127.0.0.1:64435_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.testScheduledTrigger.shard1.replica_n1:INDEX.sizeInBytes}
status=0 QTime=0
[junit4] 2> 1520761 INFO (qtp1544670790-21900) [n:127.0.0.1:64435_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metric
[...truncated too long message...]
[junit4] 2> 1560657 DEBUG (closeThreadPool-14523-thread-2) [ ]
o.a.s.c.a.ScheduledTriggers ScheduledTriggers closed completely
[junit4] 2> 1560657 DEBUG (closeThreadPool-14523-thread-2) [ ]
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
[junit4] 2> 1560657 INFO (closeThreadPool-14523-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72076850644516869-127.0.0.1:64436_solr-n_0000000000) closing
[junit4] 2> 1560742 INFO (jetty-closer-14506-thread-3) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@506966a3{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 1560742 INFO (jetty-closer-14506-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@4318af13{/solr,null,UNAVAILABLE}
[junit4] 2> 1560743 INFO (jetty-closer-14506-thread-3) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1560848 INFO (jetty-closer-14506-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72076850644516869-127.0.0.1:64436_solr-n_0000000000) closing
[junit4] 2> 1560849 INFO (jetty-closer-14506-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@6c283d2a{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 1560849 INFO (jetty-closer-14506-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@7a94c4a6{/solr,null,UNAVAILABLE}
[junit4] 2> 1560849 INFO (jetty-closer-14506-thread-1) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1560953 INFO (jetty-closer-14506-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@52d63bb4{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 1560953 INFO (jetty-closer-14506-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@4d759895{/solr,null,UNAVAILABLE}
[junit4] 2> 1560953 INFO (jetty-closer-14506-thread-2) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1560954 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 1561165 WARN (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 6
/solr/collections/testScheduledTrigger/terms/shard1
[junit4] 2> 4 /solr/aliases.json
[junit4] 2> 4 /solr/clusterprops.json
[junit4] 2> 3
/solr/configs/testScheduledTrigger.AUTOCREATED/managed-schema
[junit4] 2> 3 /solr/packages.json
[junit4] 2> 3 /solr/security.json
[junit4] 2> 2 /solr/configs/testScheduledTrigger.AUTOCREATED
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 20
/solr/collections/testScheduledTrigger/state.json
[junit4] 2> 4 /solr/clusterstate.json
[junit4] 2> 4 /solr/autoscaling.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 24 /solr/overseer/queue
[junit4] 2> 14 /solr/live_nodes
[junit4] 2> 7 /solr/collections
[junit4] 2> 4 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> 1561169 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:64413
[junit4] 2> 1561169 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:64413
[junit4] 2> 1561169 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 64413
[junit4] 2> 1563253 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[CBD14AC8EA7AC06B])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testScheduledTrigger
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=ScheduledTriggerIntegrationTest -Dtests.method=testScheduledTrigger
-Dtests.seed=CBD14AC8EA7AC06B -Dtests.slow=true -Dtests.locale=ff-Latn-GN
-Dtests.timezone=Europe/Bratislava -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] FAILURE 45.3s J1 |
ScheduledTriggerIntegrationTest.testScheduledTrigger <<<
[junit4] > Throwable #1: java.lang.AssertionError: ScheduledTrigger did
not fire in time
[junit4] > at
__randomizedtesting.SeedInfo.seed([CBD14AC8EA7AC06B:58CA02BAB4879B5F]:0)
[junit4] > at
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest.testScheduledTrigger(ScheduledTriggerIntegrationTest.java:120)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] > at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at
java.base/java.lang.reflect.Method.invoke(Method.java:564)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:832)
[junit4] 2> NOTE: leaving temporary files on disk at:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_CBD14AC8EA7AC06B-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene84): {},
docValues:{}, maxPointsInLeafNode=322, maxMBSortInHeap=7.791507663651866,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@1d7a94f7),
locale=ff-Latn-GN, timezone=Europe/Bratislava
[junit4] 2> NOTE: Windows 10 10.0 amd64/AdoptOpenJDK 14
(64-bit)/cpus=6,threads=1,free=236554024,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [TestFaceting,
TestCollectionAPI, SpellCheckCollatorWithCollapseTest, TestNumericTokenStream,
TestReload, TestRetrieveFieldsOptimizer, TestBinaryResponseWriter,
QueryEqualityTest, TermVectorComponentTest, ExecutePlanActionTest,
TestDistributedTracing, RecoveryAfterSoftCommitTest, ExternalFileFieldSortTest,
TestHighFrequencyDictionaryFactory, TestAnalyzedSuggestions,
DateRangeFieldTest, TestCloudDeleteByQuery, DeleteShardTest, EchoParamsTest,
ConnectionReuseTest, WrapperMergePolicyFactoryTest, ZkShardTermsTest,
ReplaceNodeTest, TestInitQParser, TestRandomRequestDistribution,
CurrencyRangeFacetCloudTest, JWTAuthPluginTest,
ConjunctionSolrSpellCheckerTest, MissingSegmentRecoveryTest, NumberUtilsTest,
TestSolrCloudWithSecureImpersonation, TestObjectReleaseTracker,
TestSurroundQueryParser, SpellCheckComponentTest, TestDelegationWithHadoopAuth,
ZookeeperStatusHandlerTest, RandomizedTaggerTest,
TestInPlaceUpdateWithRouteField, TestMergePolicyConfig, CustomCollectionTest,
TestRequestStatusCollectionAPI, SliceStateTest, TestCloudManagedSchema,
LeaderElectionIntegrationTest, TestBM25SimilarityFactory,
TestPostingsSolrHighlighter, CategoryRoutedAliasUpdateProcessorTest,
TestSchemaResource, XsltUpdateRequestHandlerTest, QueryElevationComponentTest,
IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestManagedSchema, DOMUtilTest,
TestRandomDVFaceting, TestRestManager, TestDistributedSearch,
MetricsHandlerTest, TestExclusionRuleCollectionAccess, TestSimExtremeIndexing,
TestJavabinTupleStreamParser, IndexSizeTriggerTest,
DefaultValueUpdateProcessorTest, LeaderVoteWaitTimeoutTest,
SolrLogAuditLoggerPluginTest, TestSolrIndexConfig, TestLegacyFieldCache,
ResourceLoaderTest, DistributedQueryComponentCustomSortTest,
TestWithCollection, TestTolerantSearch, TestDocSet, DirectSolrConnectionTest,
DistributedFacetPivotLongTailTest, ShowFileRequestHandlerTest,
CdcrRequestHandlerTest, TestLocalStatsCacheCloud, SolrLogPostToolTest,
TestFiltering, HdfsBasicDistributedZkTest, HdfsUnloadDistributedZkTest,
TestHdfsBackupRestoreCore, TestPolicyCloud, TestBadConfig,
TestShardHandlerFactory, TestPerFieldSimilarityWithDefaultOverride,
TestSubQueryTransformer, MaxSizeAutoCommitTest,
OverseerCollectionConfigSetProcessorTest, SolrTestCaseJ4Test, BasicZkTest,
ChaosMonkeyNothingIsSafeWithPullReplicasTest, CloudExitableDirectoryReaderTest,
ClusterStateMockUtilTest, ClusterStateTest, ClusterStateUpdateTest,
CollectionPropsTest, CollectionsAPISolrJTest, MetricsHistoryIntegrationTest,
MultiSolrCloudTestCaseTest, NestedShardedAtomicUpdateTest,
OverseerSolrResponseTest, OverseerSolrResponseUnsafeSerializationTest,
OverseerStatusTest, ReindexCollectionTest, TestLeaderElectionWithEmptyReplica,
TestSkipOverseerOperations, TestTolerantUpdateProcessorCloud, ZkCLITest,
NodeAddedTriggerIntegrationTest, NodeAddedTriggerTest,
ScheduledTriggerIntegrationTest]
[junit4] Completed [595/913 (1!)] on J1 in 45.32s, 1 test, 1 failure <<<
FAILURES!
[...truncated 45974 lines...]
[repro] Jenkins log URL:
https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/8858/consoleText
[repro] Revision: 28209cb8b1fe2a4d8050e4877c4df2ad5d85509b
[repro] Ant options: "-Dargs=-XX:+UseCompressedOops
-XX:+UnlockExperimentalVMOptions -XX:+UseShenandoahGC"
[repro] JUnit rest result XML files will be moved to: ./repro-reports
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr\core
[repro] ScheduledTriggerIntegrationTest
[repro] ant compile-test
[...truncated 3156 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5
-Dtests.class="*.ScheduledTriggerIntegrationTest" -Dtests.showOutput=onerror
"-Dargs=-XX:+UseCompressedOops -XX:+UnlockExperimentalVMOptions
-XX:+UseShenandoahGC" -Dtests.seed=CBD14AC8EA7AC06B -Dtests.slow=true
-Dtests.locale=ff-Latn-GN -Dtests.timezone=Europe/Bratislava
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
[...truncated 82 lines...]
[repro] Failures w/original seeds:
[repro] 0/5 failed:
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest
[repro] Exiting with code 0
[...truncated 78 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: builds-unsubscr...@lucene.apache.org
For additional commands, e-mail: builds-h...@lucene.apache.org
