Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/8849/
Java: 64bit/jdk-14 -XX:-UseCompressedOops -XX:+UseParallelGC
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([D965585A25D9D470:4A7E10287B248F44]: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 15035 lines...]
[junit4] Suite:
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest
[junit4] 2> 1545272 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[D965585A25D9D470]-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> 1545272 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[D965585A25D9D470]-worker) [ ]
o.a.s.SolrTestCaseJ4 Created dataDir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J4\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_D965585A25D9D470-001\data-dir-108-001
[junit4] 2> 1545274 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[D965585A25D9D470]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1545274 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[D965585A25D9D470]-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> 1545276 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[D965585A25D9D470]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1545282 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testScheduledTrigger
[junit4] 2> 1545285 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J4\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_D965585A25D9D470-001\tempDir-001
[junit4] 2> 1545285 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1545289 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 1545290 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1545368 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.ZkTestServer start zk server on port: 49326
[junit4] 2> 1545368 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:49326
[junit4] 2> 1545368 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:49326
[junit4] 2> 1545368 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 49326
[junit4] 2> 1545372 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1545383 INFO (zkConnectionManagerCallback-13167-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1545383 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1545401 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1545408 INFO (zkConnectionManagerCallback-13169-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1545408 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1545409 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1545414 INFO (zkConnectionManagerCallback-13171-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1545415 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1545504 INFO (jetty-launcher-13172-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1545504 INFO (jetty-launcher-13172-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1545504 INFO (jetty-launcher-13172-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1545504 INFO (jetty-launcher-13172-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1545504 INFO (jetty-launcher-13172-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> 1545504 INFO (jetty-launcher-13172-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> 1545505 INFO (jetty-launcher-13172-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1545505 INFO (jetty-launcher-13172-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1545505 INFO (jetty-launcher-13172-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1545505 INFO (jetty-launcher-13172-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1545505 INFO (jetty-launcher-13172-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1545505 INFO (jetty-launcher-13172-thread-2) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1545505 INFO (jetty-launcher-13172-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@28cf4f45{/solr,null,AVAILABLE}
[junit4] 2> 1545505 INFO (jetty-launcher-13172-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7bed5495{/solr,null,AVAILABLE}
[junit4] 2> 1545506 INFO (jetty-launcher-13172-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@2fbc243b{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:49341}
[junit4] 2> 1545506 INFO (jetty-launcher-13172-thread-2) [ ]
o.e.j.s.Server Started @1498377ms
[junit4] 2> 1545506 INFO (jetty-launcher-13172-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=49341}
[junit4] 2> 1545506 ERROR (jetty-launcher-13172-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1545506 INFO (jetty-launcher-13172-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1545506 INFO (jetty-launcher-13172-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
9.0.0
[junit4] 2> 1545506 INFO (jetty-launcher-13172-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1545506 INFO (jetty-launcher-13172-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
[junit4] 2> 1545506 INFO (jetty-launcher-13172-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-05-18T21:46:18.543856900Z
[junit4] 2> 1545506 INFO (jetty-launcher-13172-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1545510 INFO (jetty-launcher-13172-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@40e98740{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:49340}
[junit4] 2> 1545510 INFO (jetty-launcher-13172-thread-1) [ ]
o.e.j.s.Server Started @1498381ms
[junit4] 2> 1545510 INFO (jetty-launcher-13172-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=49340}
[junit4] 2> 1545510 ERROR (jetty-launcher-13172-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1545510 INFO (jetty-launcher-13172-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1545510 INFO (jetty-launcher-13172-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
9.0.0
[junit4] 2> 1545510 INFO (jetty-launcher-13172-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1545510 INFO (jetty-launcher-13172-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
[junit4] 2> 1545510 INFO (jetty-launcher-13172-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-05-18T21:46:18.547518200Z
[junit4] 2> 1545512 INFO (jetty-launcher-13172-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1545515 INFO (zkConnectionManagerCallback-13176-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1545515 INFO (jetty-launcher-13172-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1545515 INFO (zkConnectionManagerCallback-13174-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1545515 INFO (jetty-launcher-13172-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1545515 INFO (jetty-launcher-13172-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1545515 INFO (jetty-launcher-13172-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1545620 INFO (jetty-launcher-13172-thread-2) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1545627 INFO (jetty-launcher-13172-thread-1) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1545627 WARN (jetty-launcher-13172-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@196d7b19[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1545627 WARN (jetty-launcher-13172-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@196d7b19[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1545635 WARN (jetty-launcher-13172-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@1ff75f0a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1545635 WARN (jetty-launcher-13172-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@1ff75f0a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1545677 WARN (jetty-launcher-13172-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@44fc0b7c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1545677 WARN (jetty-launcher-13172-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@44fc0b7c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1545677 WARN (jetty-launcher-13172-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@72e5b7c1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1545677 WARN (jetty-launcher-13172-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@72e5b7c1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1545677 INFO (jetty-launcher-13172-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:49326/solr
[junit4] 2> 1545677 INFO (jetty-launcher-13172-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:49326/solr
[junit4] 2> 1545688 INFO (jetty-launcher-13172-thread-2)
[n:127.0.0.1:49341_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1545688 INFO (jetty-launcher-13172-thread-1)
[n:127.0.0.1:49340_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1545694 INFO (zkConnectionManagerCallback-13198-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1545694 INFO (jetty-launcher-13172-thread-1)
[n:127.0.0.1:49340_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1545694 INFO (zkConnectionManagerCallback-13196-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1545694 INFO (jetty-launcher-13172-thread-2)
[n:127.0.0.1:49341_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1545864 INFO (jetty-launcher-13172-thread-2)
[n:127.0.0.1:49341_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:49341_solr
[junit4] 2> 1545865 INFO (jetty-launcher-13172-thread-2)
[n:127.0.0.1:49341_solr ] o.a.s.c.Overseer Overseer
(id=72066113352499205-127.0.0.1:49341_solr-n_0000000000) starting
[junit4] 2> 1545880 INFO
(OverseerStateUpdate-72066113352499205-127.0.0.1:49341_solr-n_0000000000)
[n:127.0.0.1:49341_solr ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:49341_solr
[junit4] 2> 1545882 INFO (jetty-launcher-13172-thread-2)
[n:127.0.0.1:49341_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:49341_solr
[junit4] 2> 1545886 DEBUG
(OverseerAutoScalingTriggerThread-72066113352499205-127.0.0.1:49341_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and
.scheduled_maintenance triggers
[junit4] 2> 1545893 INFO
(OverseerStateUpdate-72066113352499205-127.0.0.1:49341_solr-n_0000000000)
[n:127.0.0.1:49341_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1545893 DEBUG
(OverseerAutoScalingTriggerThread-72066113352499205-127.0.0.1:49341_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with
znode version 1
[junit4] 2> 1545893 DEBUG
(OverseerAutoScalingTriggerThread-72066113352499205-127.0.0.1:49341_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1,
lastZnodeVersion 0
[junit4] 2> 1545893 DEBUG
(OverseerAutoScalingTriggerThread-72066113352499205-127.0.0.1:49341_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 1
[junit4] 2> 1545924 INFO (jetty-launcher-13172-thread-2)
[n:127.0.0.1:49341_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1545924 WARN (jetty-launcher-13172-thread-2)
[n:127.0.0.1:49341_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> 1545933 DEBUG
(OverseerAutoScalingTriggerThread-72066113352499205-127.0.0.1:49341_solr-n_0000000000)
[ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial
livenodes: [127.0.0.1:49341_solr]
[junit4] 2> 1545934 DEBUG
(OverseerAutoScalingTriggerThread-72066113352499205-127.0.0.1:49341_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1545935 DEBUG
(OverseerAutoScalingTriggerThread-72066113352499205-127.0.0.1:49341_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1,
lastZnodeVersion 1
[junit4] 2> 1545935 DEBUG (ScheduledTrigger-13205-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> 1545950 INFO (jetty-launcher-13172-thread-2)
[n:127.0.0.1:49341_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1545977 INFO (jetty-launcher-13172-thread-2)
[n:127.0.0.1:49341_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49341.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1bfd10c2
[junit4] 2> 1545991 INFO (jetty-launcher-13172-thread-2)
[n:127.0.0.1:49341_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49341.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1bfd10c2
[junit4] 2> 1545991 INFO (jetty-launcher-13172-thread-2)
[n:127.0.0.1:49341_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49341.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1bfd10c2
[junit4] 2> 1545997 INFO (jetty-launcher-13172-thread-2)
[n:127.0.0.1:49341_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J4\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_D965585A25D9D470-001\tempDir-001\node2\.
[junit4] 2> 1546199 INFO (jetty-launcher-13172-thread-1)
[n:127.0.0.1:49340_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1546227 INFO (jetty-launcher-13172-thread-1)
[n:127.0.0.1:49340_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:49340_solr as DOWN
[junit4] 2> 1546231 INFO (jetty-launcher-13172-thread-1)
[n:127.0.0.1:49340_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 1000 transient cores
[junit4] 2> 1546231 INFO (jetty-launcher-13172-thread-1)
[n:127.0.0.1:49340_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:49340_solr
[junit4] 2> 1546238 INFO (zkCallback-13195-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1546239 INFO (zkCallback-13197-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1546242 INFO (jetty-launcher-13172-thread-1)
[n:127.0.0.1:49340_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1546242 WARN (jetty-launcher-13172-thread-1)
[n:127.0.0.1:49340_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> 1546269 INFO (jetty-launcher-13172-thread-1)
[n:127.0.0.1:49340_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1546306 INFO (jetty-launcher-13172-thread-1)
[n:127.0.0.1:49340_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49340.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1bfd10c2
[junit4] 2> 1546310 INFO (jetty-launcher-13172-thread-1)
[n:127.0.0.1:49340_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49340.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1bfd10c2
[junit4] 2> 1546310 INFO (jetty-launcher-13172-thread-1)
[n:127.0.0.1:49340_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49340.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1bfd10c2
[junit4] 2> 1546310 INFO (jetty-launcher-13172-thread-1)
[n:127.0.0.1:49340_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J4\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_D965585A25D9D470-001\tempDir-001\node1\.
[junit4] 2> 1546366 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
[junit4] 2> 1546369 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1546373 INFO (zkConnectionManagerCallback-13223-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1546373 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1546375 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1546385 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at
127.0.0.1:49326/solr ready
[junit4] 2> 1546395 INFO (qtp561765988-23036) [n:127.0.0.1:49341_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 1546404 INFO (qtp1311662325-23033) [n:127.0.0.1:49340_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=3
[junit4] 2> 1546411 INFO (qtp561765988-23037) [n:127.0.0.1:49341_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=3
[junit4] 2> 1546411 DEBUG (qtp1311662325-23034) [n:127.0.0.1:49340_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1546413 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=17
[junit4] 2> 1546413 DEBUG (zkCallback-13195-thread-1) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
2
[junit4] 2> 1546415 INFO (qtp1311662325-23035) [n:127.0.0.1:49340_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> 1546415 DEBUG
(OverseerAutoScalingTriggerThread-72066113352499205-127.0.0.1:49341_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 2
[junit4] 2> 1546424 DEBUG
(OverseerAutoScalingTriggerThread-72066113352499205-127.0.0.1:49341_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1546427 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
testScheduledTrigger
[junit4] 2> 1546431 DEBUG
(OverseerAutoScalingTriggerThread-72066113352499205-127.0.0.1:49341_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2,
lastZnodeVersion 2
[junit4] 2> 1546442 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/managed-schema to
/configs/testScheduledTrigger.AUTOCREATED/managed-schema
[junit4] 2> 1546449 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/protwords.txt to
/configs/testScheduledTrigger.AUTOCREATED/protwords.txt
[junit4] 2> 1546453 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546457 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546464 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546471 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546481 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546485 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546488 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546497 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546527 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546536 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546537 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546541 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546542 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546545 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546548 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546549 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546552 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546562 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546572 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546579 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546580 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546593 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546598 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546610 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546616 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546620 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546629 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546637 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546647 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546654 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546656 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546660 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546661 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546664 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546668 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546676 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546677 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546677 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546678 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546678 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/solrconfig.xml to
/configs/testScheduledTrigger.AUTOCREATED/solrconfig.xml
[junit4] 2> 1546682 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/synonyms.txt to
/configs/testScheduledTrigger.AUTOCREATED/synonyms.txt
[junit4] 2> 1546685 INFO
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/stopwords.txt to
/configs/testScheduledTrigger.AUTOCREATED/stopwords.txt
[junit4] 2> 1546755 DEBUG (ScheduledTrigger-13205-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> 1546780 WARN
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_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> 1546783 DEBUG
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_solr ] o.a.s.c.s.c.a.PolicyHelper Creating a new session
[junit4] 2> 1546788 INFO (qtp1311662325-23033) [n:127.0.0.1:49340_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=4
[junit4] 2> 1546796 INFO (qtp561765988-23031) [n:127.0.0.1:49341_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=3
[junit4] 2> 1546796 DEBUG
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_solr ] o.a.s.c.s.c.a.PolicyHelper New session created
[junit4] 2> 1546802 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=3
[junit4] 2> 1546806 INFO (qtp561765988-23036) [n:127.0.0.1:49341_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=3
[junit4] 2> 1546817 DEBUG
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_solr ] o.a.s.c.s.c.a.PolicyHelper returnSession,
curr-time 129996278 sessionWrapper.createTime 129996252941100,
this.sessionWrapper.createTime 129996252941100
[junit4] 2> 1546827 INFO
(OverseerStateUpdate-72066113352499205-127.0.0.1:49341_solr-n_0000000000)
[n:127.0.0.1:49341_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:49341/solr";,
[junit4] 2> "node_name":"127.0.0.1:49341_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1546847 INFO
(OverseerStateUpdate-72066113352499205-127.0.0.1:49341_solr-n_0000000000)
[n:127.0.0.1:49341_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:49340/solr";,
[junit4] 2> "node_name":"127.0.0.1:49340_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1546862 INFO
(OverseerStateUpdate-72066113352499205-127.0.0.1:49341_solr-n_0000000000)
[n:127.0.0.1:49341_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:49340/solr";,
[junit4] 2> "node_name":"127.0.0.1:49340_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1547031 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_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> 1547031 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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> 1547031 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_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> 1547031 INFO (qtp561765988-23025) [n:127.0.0.1:49341_solr
x:testScheduledTrigger_shard1_replica_n1 ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 1000
transient cores
[junit4] 2> 1547062 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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> 1547067 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_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> 1547067 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_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> 1547090 INFO (qtp561765988-23025) [n:127.0.0.1:49341_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1547114 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1547126 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1547332 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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> 1547332 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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> 1547332 INFO (qtp561765988-23025) [n:127.0.0.1:49341_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_49341.solr.core.testScheduledTrigger.shard1.replica_n1'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n1') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@1bfd10c2
[junit4] 2> 1547332 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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\J4\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_D965585A25D9D470-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J4\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_D965585A25D9D470-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n1\data\]
[junit4] 2> 1547336 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_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> 1547336 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_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> 1547337 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_49340.solr.core.testScheduledTrigger.shard1.replica_n4'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n4') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@1bfd10c2
[junit4] 2> 1547337 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_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\J4\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_D965585A25D9D470-001\tempDir-001\node1\.\testScheduledTrigger_shard1_replica_n4],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J4\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_D965585A25D9D470-001\tempDir-001\node1\.\testScheduledTrigger_shard1_replica_n4\data\]
[junit4] 2> 1547345 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_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> 1547345 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_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> 1547345 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_49340.solr.core.testScheduledTrigger.shard1.replica_n2'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n2') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@1bfd10c2
[junit4] 2> 1547345 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_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\J4\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_D965585A25D9D470-001\tempDir-001\node1\.\testScheduledTrigger_shard1_replica_n2],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J4\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_D965585A25D9D470-001\tempDir-001\node1\.\testScheduledTrigger_shard1_replica_n2\data\]
[junit4] 2> 1547414 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_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> 1547414 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_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> 1547416 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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> 1547416 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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> 1547417 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_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> 1547417 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1547419 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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> 1547419 INFO (qtp561765988-23025) [n:127.0.0.1:49341_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1547424 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_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> 1547424 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_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> 1547425 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_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> 1547426 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_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> 1547426 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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> 1547426 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_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> 1547426 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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> 1547426 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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> 1547427 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_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> 1547427 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_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> 1547427 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1547427 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1547427 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_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> 1547427 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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> 1547427 INFO (qtp561765988-23025) [n:127.0.0.1:49341_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1547427 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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> 1547428 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_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> 1547428 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_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 1667066369634467840
[junit4] 2> 1547428 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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> 1547428 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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 1667066369634467840
[junit4] 2> 1547430 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_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> 1547430 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_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> 1547430 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_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> 1547430 INFO
(searcherExecutor-13225-thread-1-processing-n:127.0.0.1:49341_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:49341_solr c:testScheduledTrigger s:shard1
r:core_node3 x:testScheduledTrigger_shard1_replica_n1 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1547430 INFO
(searcherExecutor-13225-thread-1-processing-n:127.0.0.1:49341_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:49341_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> 1547430 INFO
(searcherExecutor-13227-thread-1-processing-n:127.0.0.1:49340_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:49340_solr c:testScheduledTrigger s:shard1
r:core_node6 x:testScheduledTrigger_shard1_replica_n4 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1547430 INFO
(searcherExecutor-13227-thread-1-processing-n:127.0.0.1:49340_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:49340_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> 1547431 INFO
(searcherExecutor-13225-thread-1-processing-n:127.0.0.1:49341_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:49341_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> 1547431 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_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> 1547431 INFO
(searcherExecutor-13227-thread-1-processing-n:127.0.0.1:49340_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:49340_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> 1547431 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1547431 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_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> 1547432 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_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> 1547433 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_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 1667066369639710720
[junit4] 2> 1547434 INFO
(searcherExecutor-13229-thread-1-processing-n:127.0.0.1:49340_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:49340_solr c:testScheduledTrigger s:shard1
r:core_node5 x:testScheduledTrigger_shard1_replica_n2 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1547434 INFO
(searcherExecutor-13229-thread-1-processing-n:127.0.0.1:49340_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:49340_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> 1547434 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.c.ZkShardTerms Failed to save
terms, version is not a match, retrying
[junit4] 2> 1547434 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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> 1547434 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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> 1547434 INFO
(searcherExecutor-13229-thread-1-processing-n:127.0.0.1:49340_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:49340_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> 1547435 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_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}, version=1}
[junit4] 2> 1547435 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_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> 1547436 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_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_node6=0, core_node3=0, core_node5=0}, version=2}
[junit4] 2> 1547436 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_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> 1547442 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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> 1547442 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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> 1547442 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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:49341/solr/testScheduledTrigger_shard1_replica_n1/
[junit4] 2> 1547443 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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:49341/solr
START
replicas=[http://127.0.0.1:49340/solr/testScheduledTrigger_shard1_replica_n2/,
http://127.0.0.1:49340/solr/testScheduledTrigger_shard1_replica_n4/]
nUpdates=100
[junit4] 2> 1547443 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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:49341/solr
DONE. We have no versions. sync failed.
[junit4] 2> 1547444 INFO (qtp1311662325-23033) [n:127.0.0.1:49340_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> 1547444 INFO (qtp1311662325-23100) [n:127.0.0.1:49340_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> 1547445 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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> 1547445 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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> 1547445 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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/72066113352499205-core_node3-n_0000000000
[junit4] 2> 1547445 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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:49341/solr/testScheduledTrigger_shard1_replica_n1/ shard1
[junit4] 2> 1547533 INFO (zkCallback-13195-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> 1547533 INFO (zkCallback-13195-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> 1547533 DEBUG (ScheduledTrigger-13205-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> 1547533 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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> 1547536 INFO (qtp561765988-23025) [n:127.0.0.1:49341_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=671
[junit4] 2> 1547611 INFO (zkCallback-13195-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> 1547611 INFO (zkCallback-13195-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> 1547611 INFO (zkCallback-13195-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> 1548191 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_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=1560
[junit4] 2> 1548193 INFO (qtp1311662325-23032) [n:127.0.0.1:49340_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=1564
[junit4] 2> 1548194 DEBUG
(OverseerThreadFactory-13207-thread-1-processing-n:127.0.0.1:49341_solr)
[n:127.0.0.1:49341_solr ] o.a.s.c.s.c.a.PolicyHelper session set to NULL
[junit4] 2> 1548195 INFO (qtp1311662325-23035) [n:127.0.0.1:49340_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> 1548269 DEBUG (ScheduledTrigger-13205-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 1548276 INFO (zkCallback-13195-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> 1548276 INFO (zkCallback-13195-thread-4) [ ]
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> 1548276 INFO (zkCallback-13197-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> 1548276 INFO (zkCallback-13195-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> 1548276 INFO (zkCallback-13197-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> 1548277 INFO (qtp1311662325-23035) [n:127.0.0.1:49340_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=2430
[junit4] 2> 1548277 INFO (zkCallback-13197-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> 1548278 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection:
testScheduledTrigger
[junit4] 2> 1548295 INFO (qtp1311662325-23100) [n:127.0.0.1:49340_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> 1548301 INFO (qtp1311662325-23034) [n:127.0.0.1:49340_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=4
[junit4] 2> 1548301 INFO (qtp561765988-23037) [n:127.0.0.1:49341_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> 1548339 INFO (qtp561765988-23031) [n:127.0.0.1:49341_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=45
[junit4] 2> 1548339 DEBUG (qtp1311662325-23033) [n:127.0.0.1:49340_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1548340 INFO (qtp1311662325-23033) [n:127.0.0.1:49340_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=72
[junit4] 2> 1548342 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding
port=0)
[junit4] 2> 1548342 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number
2 ...
[junit4] 2> 1548342 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.e.j.s.Server jetty-9.4.27.v20200227; built:
2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm
14+36
[junit4] 2> 1548342 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1548342 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1548342 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1548343 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6c22af38{/solr,null,AVAILABLE}
[junit4] 2> 1548350 DEBUG (zkCallback-13195-thread-1) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
3
[junit4] 2> 1548350 DEBUG
(OverseerAutoScalingTriggerThread-72066113352499205-127.0.0.1:49341_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 3
[junit4] 2> 1548351 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.e.j.s.AbstractConnector Started ServerConnector@2f7f0ac3{HTTP/1.1,
(http/1.1, h2c)}{127.0.0.1:49433}
[junit4] 2> 1548351 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.e.j.s.Server Started @1502017ms
[junit4] 2> 1548351 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=49433}
[junit4] 2> 1548351 ERROR
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging
may be missing or incomplete.
[junit4] 2> 1548351 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1548351 DEBUG
(OverseerAutoScalingTriggerThread-72066113352499205-127.0.0.1:49341_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1548351 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™
version 9.0.0
[junit4] 2> 1548351 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on
port null
[junit4] 2> 1548351 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
[junit4] 2> 1548351 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-05-18T21:46:21.388678800Z
[junit4] 2> 1548351 DEBUG
(OverseerAutoScalingTriggerThread-72066113352499205-127.0.0.1:49341_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3,
lastZnodeVersion 3
[junit4] 2> 1548352 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1548357 INFO (zkConnectionManagerCallback-13243-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1548357 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1548360 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1548445 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1548450 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.e.j.u.s.S.config Trusting all certificates configured for
Client@307b2981[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1548450 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm
configured for Client@307b2981[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1548460 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.e.j.u.s.S.config Trusting all certificates configured for
Client@2f6ed5a7[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1548460 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm
configured for Client@2f6ed5a7[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1548460 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:49326/solr
[junit4] 2> 1548466 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[n:127.0.0.1:49433_solr ] o.a.s.c.c.ConnectionManager Waiting for client
to connect to ZooKeeper
[junit4] 2> 1548484 INFO (zkConnectionManagerCallback-13254-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1548484 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[n:127.0.0.1:49433_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1548585 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[n:127.0.0.1:49433_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 1548594 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[n:127.0.0.1:49433_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:49433_solr as DOWN
[junit4] 2> 1548595 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[n:127.0.0.1:49433_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 1000 transient cores
[junit4] 2> 1548595 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[n:127.0.0.1:49433_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:49433_solr
[junit4] 2> 1548597 INFO (zkCallback-13195-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1548597 INFO (zkCallback-13222-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1548597 INFO (zkCallback-13253-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1548597 INFO (zkCallback-13197-thread-3) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1548599 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[n:127.0.0.1:49433_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1548600 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[n:127.0.0.1:49433_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> 1548615 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[n:127.0.0.1:49433_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1548641 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[n:127.0.0.1:49433_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49433.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1bfd10c2
[junit4] 2> 1548651 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[n:127.0.0.1:49433_solr ] o.a.s.m.r.SolrJmxRepo
[...truncated too long message...]
pache.solr.metrics.reporters.SolrJmxReporter@1232b561: rootName = solr_49340,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty/com.codahale.metrics.MetricRegistry@797d4ec7
[junit4] 2> 1589155 INFO (jetty-closer-13263-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster
tag=null
[junit4] 2> 1589229 INFO (jetty-closer-13263-thread-3) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@2f7f0ac3{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 1589230 INFO (jetty-closer-13263-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@6c22af38{/solr,null,UNAVAILABLE}
[junit4] 2> 1589230 INFO (jetty-closer-13263-thread-3) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1589243 INFO (jetty-closer-13263-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72066113352499205-127.0.0.1:49341_solr-n_0000000000) closing
[junit4] 2> 1589245 INFO (jetty-closer-13263-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@2fbc243b{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 1589246 INFO (zkCallback-13197-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 1589247 INFO (jetty-closer-13263-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@7bed5495{/solr,null,UNAVAILABLE}
[junit4] 2> 1589247 INFO (jetty-closer-13263-thread-1) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1589358 INFO (jetty-closer-13263-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@40e98740{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 1589358 INFO (jetty-closer-13263-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@28cf4f45{/solr,null,UNAVAILABLE}
[junit4] 2> 1589358 INFO (jetty-closer-13263-thread-2) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1589359 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 1589579 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> 8
/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> 29
/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> 22 /solr/overseer/queue
[junit4] 2> 14 /solr/live_nodes
[junit4] 2> 7 /solr/collections
[junit4] 2> 5 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> 1589585 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:49326
[junit4] 2> 1589585 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:49326
[junit4] 2> 1589586 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 49326
[junit4] 2> 1591744 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[D965585A25D9D470])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testScheduledTrigger
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=ScheduledTriggerIntegrationTest -Dtests.method=testScheduledTrigger
-Dtests.seed=D965585A25D9D470 -Dtests.slow=true -Dtests.locale=sr-Cyrl-XK
-Dtests.timezone=America/Guatemala -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] FAILURE 46.5s J4 |
ScheduledTriggerIntegrationTest.testScheduledTrigger <<<
[junit4] > Throwable #1: java.lang.AssertionError: ScheduledTrigger did
not fire in time
[junit4] > at
__randomizedtesting.SeedInfo.seed([D965585A25D9D470:4A7E10287B248F44]: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\J4\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_D965585A25D9D470-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene84): {},
docValues:{}, maxPointsInLeafNode=1097, maxMBSortInHeap=7.264596008668602,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@14a42178),
locale=sr-Cyrl-XK, timezone=America/Guatemala
[junit4] 2> NOTE: Windows 10 10.0 amd64/AdoptOpenJDK 14
(64-bit)/cpus=6,threads=1,free=191373688,total=510132224
[junit4] 2> NOTE: All tests run in this JVM: [MetricUtilsTest,
TestFieldTypeResource, MoreLikeThisComponentTest, RuleEngineTest,
AtomicUpdatesTest, DistributedFacetExistsSmallTest, TestValueSourceCache,
TestHashQParserPlugin, TestIBSimilarityFactory,
TestReplicationHandlerDiskOverFlow, UtilsToolTest, TestSolrJacksonAnnotation,
ConcurrentCreateCollectionTest, TestEmbeddedSolrServerSchemaAPI,
PackageManagerCLITest, TestConfigReload, NodeAddedTriggerIntegrationTest,
TestUtilizeNode, WordBreakSolrSpellCheckerTest, SubstringBytesRefFilterTest,
SimpleMLTQParserTest, TestClusterStateMutator,
TestSha256AuthenticationProvider, TestComponentsName, RestoreTriggerStateTest,
TestFunctionQuery, HdfsThreadLeakTest, LargeFieldTest, SampleTest,
TestFieldCacheWithThreads, TestClusterProperties, LukeRequestHandlerTest,
TestSerializedLuceneMatchVersion, TestDynamicFieldCollectionResource,
TestExpandComponent, CloneFieldUpdateProcessorFactoryTest, TestSolrCachePerf,
PKIAuthenticationIntegrationTest, TestRTGBase, TestWordDelimiterFilterFactory,
BJQParserTest, DistribDocExpirationUpdateProcessorTest,
TestExactSharedStatsCacheCloud, TestNumericRangeQuery32,
OutOfBoxZkACLAndCredentialsProvidersTest, TestAddFieldRealTimeGet,
AuditLoggerPluginTest, HDFSCollectionsAPITest, ReturnFieldsTest,
AddBlockUpdateTest, HdfsNNFailoverTest, TestChildDocTransformerHierarchy,
SolrRequestParserTest, CacheHeaderTest, ConnectionManagerTest,
RAMDirectoryFactoryTest, SearchHandlerTest, TestManagedResource,
TestOmitPositions, IndexSizeTriggerMixedBoundsTest, JSONWriterTest,
CircularListTest, DistributedSpellCheckComponentTest, AutoScalingHandlerTest,
CurrencyFieldTypeTest, ManagedSchemaRoundRobinCloudTest,
TriggerIntegrationTest, TestLocalFSCloudBackupRestore,
UUIDUpdateProcessorFallbackTest, TestCoreAdminApis,
SimpleCollectionCreateDeleteTest, RemoteQueryErrorTest,
TestSolrConfigHandlerCloud, MetricsHistoryWithAuthIntegrationTest,
TestStreamBody, TestAnalyzeInfixSuggestions, FieldMutatingUpdateProcessorTest,
BufferStoreTest, TestBinaryField, SolrXmlInZkTest,
ProtectedTermFilterFactoryTest, CleanupOldIndexTest,
CustomHighlightComponentTest, DirectoryFactoryTest, TestJsonFacets,
TestCollationFieldDocValues, MoveReplicaTest, TestDocumentBuilder,
TestGroupingSearch, TestHighlightDedupGrouping, TestSimpleTrackingShardHandler,
ActionThrottleTest, AliasIntegrationTest, ClusterStateTest,
CollectionPropsTest, CreateCollectionCleanupTest, CreateRoutedAliasTest,
DeleteInactiveReplicaTest, DeleteLastCustomShardedReplicaTest,
DistributedQueueTest, HttpPartitionTest, LeaderFailoverAfterPartitionTest,
OverseerSolrResponseTest, PeerSyncReplicationTest, TestDistributedMap,
TestHashPartitioner, TestLRUStatsCacheCloud,
TestLeaderElectionWithEmptyReplica, TestQueryingOnDownCollection,
TestRandomRequestDistribution, TestSolrCloudWithKerberosAlt,
TestStressLiveNodes, ScheduledMaintenanceTriggerTest,
ScheduledTriggerIntegrationTest]
[junit4] Completed [601/912 (1!)] on J4 in 46.50s, 1 test, 1 failure <<<
FAILURES!
[...truncated 45859 lines...]
[repro] Jenkins log URL:
https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/8849/consoleText
[repro] Revision: d2825282c984a7eca102d74f16c28eed5a4dda92
[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseParallelGC"
[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:+UseParallelGC"
-Dtests.seed=D965585A25D9D470 -Dtests.slow=true -Dtests.locale=sr-Cyrl-XK
-Dtests.timezone=America/Guatemala -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[...truncated 85 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: [email protected]
For additional commands, e-mail: [email protected]
