Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/8845/
Java: 64bit/jdk-14 -XX:+UseCompressedOops -XX:+UnlockExperimentalVMOptions
-XX:+UseShenandoahGC
1 tests failed.
FAILED:
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest.testScheduledTrigger
Error Message:
ScheduledTrigger did not fire in time
Stack Trace:
java.lang.AssertionError: ScheduledTrigger did not fire in time
at
__randomizedtesting.SeedInfo.seed([424D2AF84EA35A60:D156628A105E0154]: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 14813 lines...]
[junit4] Suite:
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest
[junit4] 2> 1624737 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[424D2AF84EA35A60]-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> 1624739 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[424D2AF84EA35A60]-worker) [ ]
o.a.s.SolrTestCaseJ4 Created dataDir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_424D2AF84EA35A60-001\data-dir-98-001
[junit4] 2> 1624739 WARN
(SUITE-ScheduledTriggerIntegrationTest-seed#[424D2AF84EA35A60]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=40 numCloses=40
[junit4] 2> 1624739 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[424D2AF84EA35A60]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1624741 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[424D2AF84EA35A60]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) 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> 1624742 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[424D2AF84EA35A60]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1624744 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testScheduledTrigger
[junit4] 2> 1624745 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_424D2AF84EA35A60-001\tempDir-001
[junit4] 2> 1624746 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1624746 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 1624746 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1624869 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.ZkTestServer start zk server on port: 57702
[junit4] 2> 1624869 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:57702
[junit4] 2> 1624869 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:57702
[junit4] 2> 1624869 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 57702
[junit4] 2> 1624873 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1624877 INFO (zkConnectionManagerCallback-12575-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1624877 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1624881 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1624884 INFO (zkConnectionManagerCallback-12577-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1624884 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1624886 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1624889 INFO (zkConnectionManagerCallback-12579-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1624889 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1625022 INFO (jetty-launcher-12580-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1625022 INFO (jetty-launcher-12580-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1625022 INFO (jetty-launcher-12580-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1625022 INFO (jetty-launcher-12580-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1625022 INFO (jetty-launcher-12580-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> 1625022 INFO (jetty-launcher-12580-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> 1625022 INFO (jetty-launcher-12580-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1625022 INFO (jetty-launcher-12580-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1625022 INFO (jetty-launcher-12580-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1625022 INFO (jetty-launcher-12580-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1625022 INFO (jetty-launcher-12580-thread-2) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1625022 INFO (jetty-launcher-12580-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1625022 INFO (jetty-launcher-12580-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6dd25bd1{/solr,null,AVAILABLE}
[junit4] 2> 1625022 INFO (jetty-launcher-12580-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@75432d3a{/solr,null,AVAILABLE}
[junit4] 2> 1625022 INFO (jetty-launcher-12580-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@17d6e61a{ssl, (ssl, alpn,
http/1.1, h2)}{127.0.0.1:57715}
[junit4] 2> 1625022 INFO (jetty-launcher-12580-thread-1) [ ]
o.e.j.s.Server Started @1574990ms
[junit4] 2> 1625022 INFO (jetty-launcher-12580-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=57715}
[junit4] 2> 1625022 INFO (jetty-launcher-12580-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@4d65b080{ssl, (ssl, alpn,
http/1.1, h2)}{127.0.0.1:57716}
[junit4] 2> 1625022 INFO (jetty-launcher-12580-thread-2) [ ]
o.e.j.s.Server Started @1574990ms
[junit4] 2> 1625022 INFO (jetty-launcher-12580-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=57716}
[junit4] 2> 1625027 ERROR (jetty-launcher-12580-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1625027 INFO (jetty-launcher-12580-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1625027 ERROR (jetty-launcher-12580-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1625027 INFO (jetty-launcher-12580-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1625027 INFO (jetty-launcher-12580-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
9.0.0
[junit4] 2> 1625027 INFO (jetty-launcher-12580-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1625027 INFO (jetty-launcher-12580-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
9.0.0
[junit4] 2> 1625027 INFO (jetty-launcher-12580-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
[junit4] 2> 1625027 INFO (jetty-launcher-12580-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-05-18T01:51:45.177817800Z
[junit4] 2> 1625027 INFO (jetty-launcher-12580-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1625027 INFO (jetty-launcher-12580-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
[junit4] 2> 1625027 INFO (jetty-launcher-12580-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-05-18T01:51:45.177817800Z
[junit4] 2> 1625028 INFO (jetty-launcher-12580-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1625028 INFO (jetty-launcher-12580-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1625030 INFO (zkConnectionManagerCallback-12584-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1625030 INFO (jetty-launcher-12580-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1625030 INFO (zkConnectionManagerCallback-12582-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1625030 INFO (jetty-launcher-12580-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1625031 INFO (jetty-launcher-12580-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1625031 INFO (jetty-launcher-12580-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1625164 INFO (jetty-launcher-12580-thread-1) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1625167 WARN (jetty-launcher-12580-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@5759eaf[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1625167 WARN (jetty-launcher-12580-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@5759eaf[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1625171 WARN (jetty-launcher-12580-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@3e904bb1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1625171 WARN (jetty-launcher-12580-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@3e904bb1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1625172 INFO (jetty-launcher-12580-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:57702/solr
[junit4] 2> 1625173 INFO (jetty-launcher-12580-thread-1)
[n:127.0.0.1:57715_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1625175 INFO (zkConnectionManagerCallback-12595-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1625175 INFO (jetty-launcher-12580-thread-1)
[n:127.0.0.1:57715_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1625274 INFO (jetty-launcher-12580-thread-1)
[n:127.0.0.1:57715_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:57715_solr
[junit4] 2> 1625275 INFO (jetty-launcher-12580-thread-1)
[n:127.0.0.1:57715_solr ] o.a.s.c.Overseer Overseer
(id=72061576913813509-127.0.0.1:57715_solr-n_0000000000) starting
[junit4] 2> 1625281 INFO
(OverseerStateUpdate-72061576913813509-127.0.0.1:57715_solr-n_0000000000)
[n:127.0.0.1:57715_solr ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:57715_solr
[junit4] 2> 1625281 INFO (jetty-launcher-12580-thread-1)
[n:127.0.0.1:57715_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:57715_solr
[junit4] 2> 1625281 DEBUG
(OverseerAutoScalingTriggerThread-72061576913813509-127.0.0.1:57715_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and
.scheduled_maintenance triggers
[junit4] 2> 1625282 INFO
(OverseerStateUpdate-72061576913813509-127.0.0.1:57715_solr-n_0000000000)
[n:127.0.0.1:57715_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1625283 DEBUG
(OverseerAutoScalingTriggerThread-72061576913813509-127.0.0.1:57715_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with
znode version 1
[junit4] 2> 1625283 DEBUG
(OverseerAutoScalingTriggerThread-72061576913813509-127.0.0.1:57715_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1,
lastZnodeVersion 0
[junit4] 2> 1625283 DEBUG
(OverseerAutoScalingTriggerThread-72061576913813509-127.0.0.1:57715_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 1
[junit4] 2> 1625284 INFO (jetty-launcher-12580-thread-1)
[n:127.0.0.1:57715_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1625284 WARN (jetty-launcher-12580-thread-1)
[n:127.0.0.1:57715_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> 1625286 INFO (jetty-launcher-12580-thread-2) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1625288 DEBUG
(OverseerAutoScalingTriggerThread-72061576913813509-127.0.0.1:57715_solr-n_0000000000)
[ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial
livenodes: [127.0.0.1:57715_solr]
[junit4] 2> 1625288 DEBUG
(OverseerAutoScalingTriggerThread-72061576913813509-127.0.0.1:57715_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1625289 DEBUG (ScheduledTrigger-12600-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> 1625289 DEBUG
(OverseerAutoScalingTriggerThread-72061576913813509-127.0.0.1:57715_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1,
lastZnodeVersion 1
[junit4] 2> 1625289 WARN (jetty-launcher-12580-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@6f7e46e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1625289 WARN (jetty-launcher-12580-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@6f7e46e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1625293 WARN (jetty-launcher-12580-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@78ea1b51[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1625293 WARN (jetty-launcher-12580-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@78ea1b51[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1625294 INFO (jetty-launcher-12580-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:57702/solr
[junit4] 2> 1625296 INFO (jetty-launcher-12580-thread-2)
[n:127.0.0.1:57716_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1625298 INFO (zkConnectionManagerCallback-12613-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1625298 INFO (jetty-launcher-12580-thread-2)
[n:127.0.0.1:57716_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1625303 INFO (jetty-launcher-12580-thread-2)
[n:127.0.0.1:57716_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1625308 INFO (jetty-launcher-12580-thread-2)
[n:127.0.0.1:57716_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:57716_solr as DOWN
[junit4] 2> 1625309 INFO (jetty-launcher-12580-thread-2)
[n:127.0.0.1:57716_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 1000 transient cores
[junit4] 2> 1625309 INFO (jetty-launcher-12580-thread-2)
[n:127.0.0.1:57716_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:57716_solr
[junit4] 2> 1625311 INFO (zkCallback-12594-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1625311 INFO (zkCallback-12612-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1625312 INFO (jetty-launcher-12580-thread-2)
[n:127.0.0.1:57716_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1625312 WARN (jetty-launcher-12580-thread-2)
[n:127.0.0.1:57716_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> 1625317 INFO (jetty-launcher-12580-thread-1)
[n:127.0.0.1:57715_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1625343 INFO (jetty-launcher-12580-thread-2)
[n:127.0.0.1:57716_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1625351 INFO (jetty-launcher-12580-thread-1)
[n:127.0.0.1:57715_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_57715.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6e6ebe02
[junit4] 2> 1625360 INFO (jetty-launcher-12580-thread-1)
[n:127.0.0.1:57715_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_57715.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6e6ebe02
[junit4] 2> 1625360 INFO (jetty-launcher-12580-thread-1)
[n:127.0.0.1:57715_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_57715.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6e6ebe02
[junit4] 2> 1625362 INFO (jetty-launcher-12580-thread-1)
[n:127.0.0.1:57715_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_424D2AF84EA35A60-001\tempDir-001\node1\.
[junit4] 2> 1625368 INFO (jetty-launcher-12580-thread-2)
[n:127.0.0.1:57716_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_57716.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6e6ebe02
[junit4] 2> 1625373 INFO (jetty-launcher-12580-thread-2)
[n:127.0.0.1:57716_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_57716.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6e6ebe02
[junit4] 2> 1625373 INFO (jetty-launcher-12580-thread-2)
[n:127.0.0.1:57716_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_57716.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6e6ebe02
[junit4] 2> 1625376 INFO (jetty-launcher-12580-thread-2)
[n:127.0.0.1:57716_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_424D2AF84EA35A60-001\tempDir-001\node2\.
[junit4] 2> 1625390 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
[junit4] 2> 1625392 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1625394 INFO (zkConnectionManagerCallback-12631-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1625394 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1625395 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1625396 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at
127.0.0.1:57702/solr ready
[junit4] 2> 1625412 INFO (qtp489590122-20900) [n:127.0.0.1:57715_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1625426 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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=2
[junit4] 2> 1625444 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_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=2
[junit4] 2> 1625444 DEBUG (qtp489590122-20896) [n:127.0.0.1:57715_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1625446 INFO (qtp489590122-20896) [n:127.0.0.1:57715_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=24
[junit4] 2> 1625446 DEBUG (zkCallback-12594-thread-1) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
2
[junit4] 2> 1625446 DEBUG
(OverseerAutoScalingTriggerThread-72061576913813509-127.0.0.1:57715_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 2
[junit4] 2> 1625449 DEBUG
(OverseerAutoScalingTriggerThread-72061576913813509-127.0.0.1:57715_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1625450 DEBUG
(OverseerAutoScalingTriggerThread-72061576913813509-127.0.0.1:57715_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2,
lastZnodeVersion 2
[junit4] 2> 1625459 INFO (qtp1201527792-20893) [n:127.0.0.1:57716_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> 1625463 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
testScheduledTrigger
[junit4] 2> 1625463 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/managed-schema to
/configs/testScheduledTrigger.AUTOCREATED/managed-schema
[junit4] 2> 1625466 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/protwords.txt to
/configs/testScheduledTrigger.AUTOCREATED/protwords.txt
[junit4] 2> 1625468 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625469 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625471 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625474 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625476 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625479 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625482 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625485 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625486 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625488 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625490 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625492 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625494 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625496 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625498 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625500 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625502 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625504 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625506 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625507 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625510 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625512 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625514 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625516 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625518 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625520 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625522 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625524 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625527 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625528 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625530 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625533 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625534 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625537 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625538 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625540 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625542 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625544 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625546 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625549 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/solrconfig.xml to
/configs/testScheduledTrigger.AUTOCREATED/solrconfig.xml
[junit4] 2> 1625551 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/synonyms.txt to
/configs/testScheduledTrigger.AUTOCREATED/synonyms.txt
[junit4] 2> 1625552 INFO
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/stopwords.txt to
/configs/testScheduledTrigger.AUTOCREATED/stopwords.txt
[junit4] 2> 1625686 WARN
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_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> 1625687 DEBUG
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_solr ] o.a.s.c.s.c.a.PolicyHelper Creating a new session
[junit4] 2> 1625691 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_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=2
[junit4] 2> 1625695 INFO (qtp489590122-20894) [n:127.0.0.1:57715_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=1
[junit4] 2> 1625695 DEBUG
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_solr ] o.a.s.c.s.c.a.PolicyHelper New session created
[junit4] 2> 1625699 INFO (qtp1201527792-20897) [n:127.0.0.1:57716_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=1
[junit4] 2> 1625702 INFO (qtp489590122-20898) [n:127.0.0.1:57715_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=2
[junit4] 2> 1625704 DEBUG
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_solr ] o.a.s.c.s.c.a.PolicyHelper returnSession,
curr-time 60774637 sessionWrapper.createTime 60774631016500,
this.sessionWrapper.createTime 60774631016500
[junit4] 2> 1625708 INFO
(OverseerStateUpdate-72061576913813509-127.0.0.1:57715_solr-n_0000000000)
[n:127.0.0.1:57715_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":"https://127.0.0.1:57715/solr";,
[junit4] 2> "node_name":"127.0.0.1:57715_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1625710 INFO
(OverseerStateUpdate-72061576913813509-127.0.0.1:57715_solr-n_0000000000)
[n:127.0.0.1:57715_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":"https://127.0.0.1:57716/solr";,
[junit4] 2> "node_name":"127.0.0.1:57716_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1625712 INFO
(OverseerStateUpdate-72061576913813509-127.0.0.1:57715_solr-n_0000000000)
[n:127.0.0.1:57715_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":"https://127.0.0.1:57716/solr";,
[junit4] 2> "node_name":"127.0.0.1:57716_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1625963 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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> 1625963 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_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> 1625964 INFO (qtp489590122-20900) [n:127.0.0.1:57715_solr
x:testScheduledTrigger_shard1_replica_n1 ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 1000
transient cores
[junit4] 2> 1625972 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_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> 1625979 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_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> 1625981 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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> 1625987 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_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> 1626004 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1626098 INFO (qtp489590122-20900) [n:127.0.0.1:57715_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1626302 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1626517 DEBUG (ScheduledTrigger-12600-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> 1627039 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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> 1627039 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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> 1627039 INFO (qtp489590122-20900) [n:127.0.0.1:57715_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_57715.solr.core.testScheduledTrigger.shard1.replica_n1'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n1') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@6e6ebe02
[junit4] 2> 1627039 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_424D2AF84EA35A60-001\tempDir-001\node1\.\testScheduledTrigger_shard1_replica_n1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_424D2AF84EA35A60-001\tempDir-001\node1\.\testScheduledTrigger_shard1_replica_n1\data\]
[junit4] 2> 1627049 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_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> 1627049 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_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> 1627049 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_57716.solr.core.testScheduledTrigger.shard1.replica_n2'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n2') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@6e6ebe02
[junit4] 2> 1627049 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_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\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_424D2AF84EA35A60-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n2],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_424D2AF84EA35A60-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n2\data\]
[junit4] 2> 1627057 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_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> 1627057 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_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> 1627094 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_57716.solr.core.testScheduledTrigger.shard1.replica_n4'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n4') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@6e6ebe02
[junit4] 2> 1627094 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_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\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_424D2AF84EA35A60-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n4],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_424D2AF84EA35A60-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n4\data\]
[junit4] 2> 1627217 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_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> 1627217 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_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> 1627217 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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> 1627217 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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> 1627220 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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> 1627220 INFO (qtp489590122-20900) [n:127.0.0.1:57715_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1627222 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_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> 1627222 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1627225 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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> 1627225 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_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> 1627225 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_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> 1627225 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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> 1627225 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_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> 1627225 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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> 1627226 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_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> 1627226 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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> 1627226 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1627226 INFO (qtp489590122-20900) [n:127.0.0.1:57715_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1627226 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_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> 1627226 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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> 1627226 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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> 1627226 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_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> 1627226 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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 1666991214953496576
[junit4] 2> 1627226 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_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 1666991214953496576
[junit4] 2> 1627231 INFO
(searcherExecutor-12635-thread-1-processing-n:127.0.0.1:57716_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:57716_solr c:testScheduledTrigger s:shard1
r:core_node5 x:testScheduledTrigger_shard1_replica_n2 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1627231 INFO
(searcherExecutor-12635-thread-1-processing-n:127.0.0.1:57716_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:57716_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> 1627231 INFO
(searcherExecutor-12633-thread-1-processing-n:127.0.0.1:57715_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:57715_solr c:testScheduledTrigger s:shard1
r:core_node3 x:testScheduledTrigger_shard1_replica_n1 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1627231 INFO
(searcherExecutor-12633-thread-1-processing-n:127.0.0.1:57715_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:57715_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> 1627231 INFO
(searcherExecutor-12635-thread-1-processing-n:127.0.0.1:57716_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:57716_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> 1627231 INFO
(searcherExecutor-12633-thread-1-processing-n:127.0.0.1:57715_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:57715_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> 1627236 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_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_node5=0}, version=0}
[junit4] 2> 1627236 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_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> 1627236 INFO (qtp489590122-20900) [n:127.0.0.1:57715_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Failed to save
terms, version is not a match, retrying
[junit4] 2> 1627237 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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, core_node5=0}, version=1}
[junit4] 2> 1627237 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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> 1627243 INFO (qtp489590122-20900) [n:127.0.0.1:57715_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext
Waiting until we see more replicas up for shard shard1: total=3 found=2
timeoute in=9998ms
[junit4] 2> 1627257 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_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> 1627257 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_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> 1627261 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_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> 1627261 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1627274 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_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> 1627275 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_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> 1627275 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_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> 1627275 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_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> 1627275 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1627275 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_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> 1627275 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_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> 1627275 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_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 1666991215004876800
[junit4] 2> 1627279 INFO
(searcherExecutor-12637-thread-1-processing-n:127.0.0.1:57716_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:57716_solr c:testScheduledTrigger s:shard1
r:core_node6 x:testScheduledTrigger_shard1_replica_n4 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1627279 INFO
(searcherExecutor-12637-thread-1-processing-n:127.0.0.1:57716_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:57716_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> 1627281 INFO
(searcherExecutor-12637-thread-1-processing-n:127.0.0.1:57716_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:57716_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> 1627282 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.c.ZkShardTerms Successful
update of terms at /collections/testScheduledTrigger/terms/shard1 to
Terms{values={core_node6=0, core_node3=0, core_node5=0}, version=2}
[junit4] 2> 1627282 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_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> 1627751 DEBUG (ScheduledTrigger-12600-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> 1627870 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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> 1627870 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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> 1627870 INFO (qtp489590122-20900) [n:127.0.0.1:57715_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas
to https://127.0.0.1:57715/solr/testScheduledTrigger_shard1_replica_n1/
[junit4] 2> 1627875 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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=https://127.0.0.1:57715/solr
START
replicas=[https://127.0.0.1:57716/solr/testScheduledTrigger_shard1_replica_n2/,
https://127.0.0.1:57716/solr/testScheduledTrigger_shard1_replica_n4/]
nUpdates=100
[junit4] 2> 1627876 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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=https://127.0.0.1:57715/solr
DONE. We have no versions. sync failed.
[junit4] 2> 1627896 INFO (qtp1201527792-20897) [n:127.0.0.1:57716_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> 1627901 INFO (qtp1201527792-20964) [n:127.0.0.1:57716_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> 1627903 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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> 1627903 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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> 1627903 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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/72061576913813509-core_node3-n_0000000000
[junit4] 2> 1627923 INFO (qtp489590122-20900) [n:127.0.0.1:57715_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I
am the new leader:
https://127.0.0.1:57715/solr/testScheduledTrigger_shard1_replica_n1/ shard1
[junit4] 2> 1628056 INFO (zkCallback-12594-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> 1628062 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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> 1628072 INFO (qtp489590122-20900) [n:127.0.0.1:57715_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=1718
[junit4] 2> 1628189 INFO (zkCallback-12594-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> 1628189 INFO (zkCallback-12594-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> 1628475 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_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=2039
[junit4] 2> 1628519 INFO (qtp1201527792-20899) [n:127.0.0.1:57716_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=2082
[junit4] 2> 1628520 DEBUG
(OverseerThreadFactory-12602-thread-1-processing-n:127.0.0.1:57715_solr)
[n:127.0.0.1:57715_solr ] o.a.s.c.s.c.a.PolicyHelper session set to NULL
[junit4] 2> 1628520 INFO (qtp1201527792-20893) [n:127.0.0.1:57716_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> 1628640 INFO (zkCallback-12612-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> 1628640 INFO (zkCallback-12594-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> 1628640 INFO (zkCallback-12594-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> 1628640 INFO (zkCallback-12612-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> 1628640 INFO (qtp1201527792-20893) [n:127.0.0.1:57716_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=2593
[junit4] 2> 1628641 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection:
testScheduledTrigger
[junit4] 2> 1628654 INFO (qtp1201527792-20895) [n:127.0.0.1:57716_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> 1628657 INFO (qtp1201527792-20893) [n:127.0.0.1:57716_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=2
[junit4] 2> 1628668 INFO (qtp489590122-20898) [n:127.0.0.1:57715_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> 1628670 INFO (qtp489590122-20896) [n:127.0.0.1:57715_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=1
[junit4] 2> 1628670 DEBUG (qtp1201527792-20963) [n:127.0.0.1:57716_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1628670 INFO (qtp1201527792-20963) [n:127.0.0.1:57716_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=22
[junit4] 2> 1628671 DEBUG (zkCallback-12594-thread-2) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
3
[junit4] 2> 1628672 DEBUG
(OverseerAutoScalingTriggerThread-72061576913813509-127.0.0.1:57715_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 3
[junit4] 2> 1628672 DEBUG
(OverseerAutoScalingTriggerThread-72061576913813509-127.0.0.1:57715_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1628673 DEBUG
(OverseerAutoScalingTriggerThread-72061576913813509-127.0.0.1:57715_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3,
lastZnodeVersion 3
[junit4] 2> 1628675 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding
port=0)
[junit4] 2> 1628675 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number
2 ...
[junit4] 2> 1628675 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.e.j.s.Server jetty-9.4.27.v20200227; built:
2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm
14+36
[junit4] 2> 1628676 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1628676 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1628676 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1628677 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@55b52a28{/solr,null,AVAILABLE}
[junit4] 2> 1628678 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.e.j.s.AbstractConnector Started ServerConnector@23c8786{ssl, (ssl,
alpn, http/1.1, h2)}{127.0.0.1:57857}
[junit4] 2> 1628678 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.e.j.s.Server Started @1577966ms
[junit4] 2> 1628678 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=57857}
[junit4] 2> 1628678 ERROR
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging
may be missing or incomplete.
[junit4] 2> 1628678 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1628679 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr?
version 9.0.0
[junit4] 2> 1628679 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on
port null
[junit4] 2> 1628679 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
[junit4] 2> 1628679 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-05-18T01:51:48.829596600Z
[junit4] 2> 1628680 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1628682 INFO (zkConnectionManagerCallback-12651-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1628682 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1628682 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1628813 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1628816 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.e.j.u.s.S.config Trusting all certificates configured for
Client@b1d0687[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1628816 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm
configured for Client@b1d0687[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1628820 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.e.j.u.s.S.config Trusting all certificates configured for
Client@998bc7a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1628820 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm
configured for Client@998bc7a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1628821 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:57702/solr
[junit4] 2> 1628823 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[n:127.0.0.1:57857_solr ] o.a.s.c.c.ConnectionManager Waiting for client
to connect to ZooKeeper
[junit4] 2> 1628826 INFO (zkConnectionManagerCallback-12662-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1628826 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[n:127.0.0.1:57857_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1628832 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[n:127.0.0.1:57857_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 1628838 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[n:127.0.0.1:57857_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:57857_solr as DOWN
[junit4] 2> 1628840 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[n:127.0.0.1:57857_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 1000 transient cores
[junit4] 2> 1628840 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[n:127.0.0.1:57857_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:57857_solr
[junit4] 2> 1628842 INFO (zkCallback-12594-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1628842 INFO (zkCallback-12612-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1628842 INFO (zkCallback-12630-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1628842 INFO (zkCallback-12661-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1628845 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[n:127.0.0.1:57857_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1628845 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[n:127.0.0.1:57857_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> 1628880 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[n:127.0.0.1:57857_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1628907 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[n:127.0.0.1:57857_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_57857.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6e6ebe02
[junit4] 2> 1628916 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[n:127.0.0.1:57857_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_57857.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6e6ebe02
[junit4] 2> 1628916 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[n:127.0.0.1:57857_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_57857.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6e6ebe02
[junit4] 2> 1628918 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[n:127.0.0.1:57857_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_424D2AF84EA35A60-001\tempDir-001\node3\.
[junit4] 2> 1628934 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrig
[...truncated too long message...]
.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty
tag=null
[junit4] 2> 1688914 INFO (jetty-closer-12671-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@373926f7: rootName =
solr_57716, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty/com.codahale.metrics.MetricRegistry@1f6b134a
[junit4] 2> 1688914 INFO (jetty-closer-12671-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster
tag=null
[junit4] 2> 1688997 INFO (jetty-closer-12671-thread-3) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@23c8786{ssl, (ssl, alpn,
http/1.1, h2)}{127.0.0.1:0}
[junit4] 2> 1688997 INFO (jetty-closer-12671-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@55b52a28{/solr,null,UNAVAILABLE}
[junit4] 2> 1688997 INFO (jetty-closer-12671-thread-3) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1689106 INFO (jetty-closer-12671-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@4d65b080{ssl, (ssl, alpn,
http/1.1, h2)}{127.0.0.1:0}
[junit4] 2> 1689106 INFO (jetty-closer-12671-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@75432d3a{/solr,null,UNAVAILABLE}
[junit4] 2> 1689106 INFO (jetty-closer-12671-thread-2) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1689214 INFO (jetty-closer-12671-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72061576913813509-127.0.0.1:57715_solr-n_0000000000) closing
[junit4] 2> 1689215 INFO (jetty-closer-12671-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@17d6e61a{ssl, (ssl, alpn,
http/1.1, h2)}{127.0.0.1:0}
[junit4] 2> 1689215 INFO (jetty-closer-12671-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@6dd25bd1{/solr,null,UNAVAILABLE}
[junit4] 2> 1689215 INFO (jetty-closer-12671-thread-1) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1689215 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 1689447 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> 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> 22
/solr/collections/testScheduledTrigger/state.json
[junit4] 2> 4 /solr/clusterstate.json
[junit4] 2> 4 /solr/autoscaling.json
[junit4] 2> 4 /solr/clusterprops.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 24 /solr/overseer/queue
[junit4] 2> 14 /solr/live_nodes
[junit4] 2> 7 /solr/collections
[junit4] 2> 4 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> 1689460 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:57702
[junit4] 2> 1689460 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:57702
[junit4] 2> 1689460 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 57702
[junit4] 2> 1691630 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[424D2AF84EA35A60])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testScheduledTrigger
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=ScheduledTriggerIntegrationTest -Dtests.method=testScheduledTrigger
-Dtests.seed=424D2AF84EA35A60 -Dtests.slow=true -Dtests.locale=kok
-Dtests.timezone=Africa/Abidjan -Dtests.asserts=true
-Dtests.file.encoding=US-ASCII
[junit4] FAILURE 66.9s J3 |
ScheduledTriggerIntegrationTest.testScheduledTrigger <<<
[junit4] > Throwable #1: java.lang.AssertionError: ScheduledTrigger did
not fire in time
[junit4] > at
__randomizedtesting.SeedInfo.seed([424D2AF84EA35A60:D156628A105E0154]: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\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_424D2AF84EA35A60-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene84): {},
docValues:{}, maxPointsInLeafNode=1844, maxMBSortInHeap=7.709659356510665,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@1c4302c1),
locale=kok, timezone=Africa/Abidjan
[junit4] 2> NOTE: Windows 10 10.0 amd64/AdoptOpenJDK 14
(64-bit)/cpus=6,threads=1,free=163790368,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [TriggerEventQueueTest,
TestQueryingOnDownCollection, TestExportWriter, TestSchemalessBufferedUpdates,
PropertiesRequestHandlerTest, AutoAddReplicasPlanActionTest, IndexSchemaTest,
TestStressInPlaceUpdates, HttpPartitionTest, ConfigSetsAPITest,
TestNonDefinedSimilarityFactory, TaggerTest,
TestDynamicFieldNamesIndexCorrectly, ShardRoutingCustomTest, CoreSorterTest,
SparseHLLTest, CloudReplicaSourceTest, TestSimLargeCluster,
MoveReplicaHDFSTest, HighlighterMaxOffsetTest, BasicZkTest, NodeMutatorTest,
TestCopyFieldCollectionResource, ResponseLogComponentTest, TestConfigsApi,
SearchRateTriggerIntegrationTest, TestSolrConfigHandler,
TestSimpleTrackingShardHandler, TestDynamicLoading, NestedAtomicUpdateTest,
ClusterStateUpdateTest, NodeMarkersRegistrationTest, TestMaxScoreQueryParser,
TestReplicationHandlerBackup, TestTolerantUpdateProcessorRandomCloud,
BinaryUpdateRequestHandlerTest, AuditLoggerIntegrationTest,
RangeFacetCloudTest, ShardSplitTest, DistributedExpandComponentTest,
DynamicMapsTest, TestMultiValuedNumericRangeQuery, TestQueryUtils,
AutoscalingHistoryHandlerTest, LeaderFailoverAfterPartitionTest,
SolrCloudExampleTest, TestStressReorder, SolrCoreCheckLockOnStartupTest,
TimeZoneUtilsTest, TestSimDistribStateManager, TestJsonFacetRefinement,
TestSimTriggerIntegration, TestManagedSynonymGraphFilterFactory,
SortByFunctionTest, HdfsSyncSliceTest, TestFieldCacheVsDocValues,
OutputWriterTest, TestUnifiedSolrHighlighterWithoutStoredId,
TestCursorMarkWithoutUniqueKey, DirectUpdateHandlerTest, TestRequestForwarding,
HttpTriggerListenerTest, TestSQLHandlerNonCloud, DistanceFunctionTest,
CloudMLTQParserTest, TestSubQueryTransformerDistrib,
TestDocBasedVersionConstraints, TlogReplayBufferedWhileIndexingTest,
SimplePostToolTest, MetricTriggerTest, TestGroupingSearch,
TestInPlaceUpdatesStandalone, SpatialFilterTest, CdcrWithNodesRestartsTest,
AssignTest, MoreLikeThisHandlerTest, TestCloudPhrasesIdentificationComponent,
TestCustomDocTransformer, BlockDirectoryTest, TestSearchPerf,
TestAuthenticationFramework, SolrCloudReportersTest, TestFreeTextSuggestions,
PeerSyncWithIndexFingerprintCachingTest, SplitHandlerTest,
TestReversedWildcardFilterFactory, TestPushWriter, TestTrieFacet,
ZkControllerTest, DistributedVersionInfoTest, LeaderTragicEventTest,
LeaderVoteWaitTimeoutTest, MetricsHistoryWithAuthIntegrationTest,
MultiThreadedOCPTest, ReindexCollectionTest, TestDeleteCollectionOnDownNodes,
TestHashPartitioner, TestLRUStatsCacheCloud, TestOnReconnectListenerSupport,
TestPullReplica, TestSegmentSorting, TestSolrCloudWithDelegationTokens,
UnloadDistributedZkTest, ConcurrentDeleteAndCreateCollectionTest,
CustomCollectionTest, TestHdfsCloudBackupRestore,
TestLocalFSCloudBackupRestore, ScheduledTriggerIntegrationTest]
[junit4] Completed [571/912 (1!)] on J3 in 66.93s, 1 test, 1 failure <<<
FAILURES!
[...truncated 46094 lines...]
[repro] Jenkins log URL:
https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/8845/consoleText
[repro] Revision: 06df50e759a8edf2315dc421a5b12570577471a3
[repro] Ant options: "-Dargs=-XX:+UseCompressedOops
-XX:+UnlockExperimentalVMOptions -XX:+UseShenandoahGC"
[repro] JUnit rest result XML files will be moved to: ./repro-reports
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr\core
[repro] ScheduledTriggerIntegrationTest
[repro] ant compile-test
[...truncated 3156 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5
-Dtests.class="*.ScheduledTriggerIntegrationTest" -Dtests.showOutput=onerror
"-Dargs=-XX:+UseCompressedOops -XX:+UnlockExperimentalVMOptions
-XX:+UseShenandoahGC" -Dtests.seed=424D2AF84EA35A60 -Dtests.slow=true
-Dtests.locale=kok -Dtests.timezone=Africa/Abidjan -Dtests.asserts=true
-Dtests.file.encoding=US-ASCII
[...truncated 82 lines...]
[repro] Failures w/original seeds:
[repro] 0/5 failed:
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest
[repro] Exiting with code 0
[...truncated 78 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
