Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Windows/1140/
Java: 64bit/jdk-11.0.6 -XX:-UseCompressedOops -XX:+UseSerialGC
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([472A5CBEEB87541B:D43114CCB57A0F2F]: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:566)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:834)
Build Log:
[...truncated 15452 lines...]
[junit4] Suite:
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest
[junit4] 2> 1605297 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[472A5CBEEB87541B]-worker) [ ]
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to
test-framework derived value of
'C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\server\solr\configsets\_default\conf'
[junit4] 2> 1605297 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[472A5CBEEB87541B]-worker) [ ]
o.a.s.SolrTestCaseJ4 Created dataDir:
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J2\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_472A5CBEEB87541B-001\data-dir-99-001
[junit4] 2> 1605297 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[472A5CBEEB87541B]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1605299 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[472A5CBEEB87541B]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0,
clientAuth=0.0/0.0)
[junit4] 2> 1605299 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[472A5CBEEB87541B]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1605302 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testScheduledTrigger
[junit4] 2> 1605302 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J2\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_472A5CBEEB87541B-001\tempDir-001
[junit4] 2> 1605302 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1605302 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 1605302 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1605429 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.ZkTestServer start zk server on port: 55811
[junit4] 2> 1605429 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:55811
[junit4] 2> 1605429 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:55811
[junit4] 2> 1605429 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 55811
[junit4] 2> 1605431 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1605436 INFO (zkConnectionManagerCallback-10413-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1605436 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1605438 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1605441 INFO (zkConnectionManagerCallback-10415-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1605441 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1605441 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1605443 INFO (zkConnectionManagerCallback-10417-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1605443 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1605575 WARN (jetty-launcher-10418-thread-2) [ ]
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content,
break even is size 23
[junit4] 2> 1605575 WARN (jetty-launcher-10418-thread-1) [ ]
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content,
break even is size 23
[junit4] 2> 1605576 INFO (jetty-launcher-10418-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1605576 INFO (jetty-launcher-10418-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1605576 INFO (jetty-launcher-10418-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1605576 INFO (jetty-launcher-10418-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1605576 INFO (jetty-launcher-10418-thread-1) [ ]
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git:
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 11.0.6+10
[junit4] 2> 1605576 INFO (jetty-launcher-10418-thread-2) [ ]
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git:
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 11.0.6+10
[junit4] 2> 1605577 INFO (jetty-launcher-10418-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1605577 INFO (jetty-launcher-10418-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1605577 INFO (jetty-launcher-10418-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1605577 INFO (jetty-launcher-10418-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1605577 INFO (jetty-launcher-10418-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1605577 INFO (jetty-launcher-10418-thread-2) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1605577 INFO (jetty-launcher-10418-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@ed7256e{/solr,null,AVAILABLE}
[junit4] 2> 1605577 INFO (jetty-launcher-10418-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@3553a005{/solr,null,AVAILABLE}
[junit4] 2> 1605579 INFO (jetty-launcher-10418-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@f3a0365{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:55824}
[junit4] 2> 1605579 INFO (jetty-launcher-10418-thread-1) [ ]
o.e.j.s.Server Started @1543116ms
[junit4] 2> 1605579 INFO (jetty-launcher-10418-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@1533b2d1{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:55825}
[junit4] 2> 1605579 INFO (jetty-launcher-10418-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=55824}
[junit4] 2> 1605579 INFO (jetty-launcher-10418-thread-2) [ ]
o.e.j.s.Server Started @1543116ms
[junit4] 2> 1605579 INFO (jetty-launcher-10418-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=55825}
[junit4] 2> 1605579 ERROR (jetty-launcher-10418-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1605579 INFO (jetty-launcher-10418-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1605579 INFO (jetty-launcher-10418-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.6.0
[junit4] 2> 1605579 INFO (jetty-launcher-10418-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1605579 INFO (jetty-launcher-10418-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr
[junit4] 2> 1605579 ERROR (jetty-launcher-10418-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1605579 INFO (jetty-launcher-10418-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1605579 INFO (jetty-launcher-10418-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-05-18T07:54:35.634494300Z
[junit4] 2> 1605579 INFO (jetty-launcher-10418-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.6.0
[junit4] 2> 1605579 INFO (jetty-launcher-10418-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1605579 INFO (jetty-launcher-10418-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr
[junit4] 2> 1605579 INFO (jetty-launcher-10418-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-05-18T07:54:35.634494300Z
[junit4] 2> 1605580 INFO (jetty-launcher-10418-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1605580 INFO (jetty-launcher-10418-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1605582 INFO (zkConnectionManagerCallback-10420-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1605582 INFO (jetty-launcher-10418-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1605582 INFO (zkConnectionManagerCallback-10422-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1605582 INFO (jetty-launcher-10418-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1605583 INFO (jetty-launcher-10418-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1605583 INFO (jetty-launcher-10418-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1605904 INFO (jetty-launcher-10418-thread-2) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1605905 WARN (jetty-launcher-10418-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@652486bf[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1605905 WARN (jetty-launcher-10418-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@652486bf[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1605907 WARN (jetty-launcher-10418-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@75e984e7[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1605907 WARN (jetty-launcher-10418-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@75e984e7[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1605909 INFO (jetty-launcher-10418-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:55811/solr
[junit4] 2> 1605910 INFO (jetty-launcher-10418-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1605912 INFO (zkConnectionManagerCallback-10436-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1605912 INFO (jetty-launcher-10418-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1606041 INFO (jetty-launcher-10418-thread-2)
[n:127.0.0.1:55825_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1606044 INFO (zkConnectionManagerCallback-10438-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1606044 INFO (jetty-launcher-10418-thread-2)
[n:127.0.0.1:55825_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1606137 INFO (jetty-launcher-10418-thread-2)
[n:127.0.0.1:55825_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:55825_solr
[junit4] 2> 1606137 INFO (jetty-launcher-10418-thread-2)
[n:127.0.0.1:55825_solr ] o.a.s.c.Overseer Overseer
(id=72062954422992902-127.0.0.1:55825_solr-n_0000000000) starting
[junit4] 2> 1606142 INFO
(OverseerStateUpdate-72062954422992902-127.0.0.1:55825_solr-n_0000000000)
[n:127.0.0.1:55825_solr ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:55825_solr
[junit4] 2> 1606142 INFO (jetty-launcher-10418-thread-2)
[n:127.0.0.1:55825_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:55825_solr
[junit4] 2> 1606143 DEBUG
(OverseerAutoScalingTriggerThread-72062954422992902-127.0.0.1:55825_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and
.scheduled_maintenance triggers
[junit4] 2> 1606143 INFO
(OverseerStateUpdate-72062954422992902-127.0.0.1:55825_solr-n_0000000000)
[n:127.0.0.1:55825_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1606144 DEBUG
(OverseerAutoScalingTriggerThread-72062954422992902-127.0.0.1:55825_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with
znode version 1
[junit4] 2> 1606145 DEBUG
(OverseerAutoScalingTriggerThread-72062954422992902-127.0.0.1:55825_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1,
lastZnodeVersion 0
[junit4] 2> 1606145 DEBUG
(OverseerAutoScalingTriggerThread-72062954422992902-127.0.0.1:55825_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 1
[junit4] 2> 1606145 INFO (jetty-launcher-10418-thread-2)
[n:127.0.0.1:55825_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1606145 WARN (jetty-launcher-10418-thread-2)
[n:127.0.0.1:55825_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> 1606147 DEBUG
(OverseerAutoScalingTriggerThread-72062954422992902-127.0.0.1:55825_solr-n_0000000000)
[ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial
livenodes: [127.0.0.1:55825_solr]
[junit4] 2> 1606147 DEBUG
(OverseerAutoScalingTriggerThread-72062954422992902-127.0.0.1:55825_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1606147 DEBUG
(OverseerAutoScalingTriggerThread-72062954422992902-127.0.0.1:55825_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1,
lastZnodeVersion 1
[junit4] 2> 1606147 DEBUG (ScheduledTrigger-10443-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> 1606178 INFO (jetty-launcher-10418-thread-2)
[n:127.0.0.1:55825_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1606199 INFO (jetty-launcher-10418-thread-2)
[n:127.0.0.1:55825_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_55825.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@648bbce6
[junit4] 2> 1606201 INFO (jetty-launcher-10418-thread-2)
[n:127.0.0.1:55825_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_55825.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@648bbce6
[junit4] 2> 1606201 INFO (jetty-launcher-10418-thread-2)
[n:127.0.0.1:55825_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_55825.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@648bbce6
[junit4] 2> 1606206 INFO (jetty-launcher-10418-thread-2)
[n:127.0.0.1:55825_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J2\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_472A5CBEEB87541B-001\tempDir-001\node2\.
[junit4] 2> 1606243 INFO (jetty-launcher-10418-thread-1) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1606245 WARN (jetty-launcher-10418-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@2ab79423[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1606245 WARN (jetty-launcher-10418-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@2ab79423[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1606245 WARN (jetty-launcher-10418-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@348e1390[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1606245 WARN (jetty-launcher-10418-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@348e1390[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1606250 INFO (jetty-launcher-10418-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:55811/solr
[junit4] 2> 1606251 INFO (jetty-launcher-10418-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1606253 INFO (zkConnectionManagerCallback-10458-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1606253 INFO (jetty-launcher-10418-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1606380 INFO (jetty-launcher-10418-thread-1)
[n:127.0.0.1:55824_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1606380 INFO (zkConnectionManagerCallback-10460-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1606380 INFO (jetty-launcher-10418-thread-1)
[n:127.0.0.1:55824_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1606389 INFO (jetty-launcher-10418-thread-1)
[n:127.0.0.1:55824_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1606393 INFO (jetty-launcher-10418-thread-1)
[n:127.0.0.1:55824_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:55824_solr as DOWN
[junit4] 2> 1606394 INFO (jetty-launcher-10418-thread-1)
[n:127.0.0.1:55824_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 1606394 INFO (jetty-launcher-10418-thread-1)
[n:127.0.0.1:55824_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:55824_solr
[junit4] 2> 1606396 INFO (zkCallback-10437-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1606396 INFO (zkCallback-10459-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1606397 INFO (jetty-launcher-10418-thread-1)
[n:127.0.0.1:55824_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1606397 WARN (jetty-launcher-10418-thread-1)
[n:127.0.0.1:55824_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> 1606420 INFO (jetty-launcher-10418-thread-1)
[n:127.0.0.1:55824_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1606439 INFO (jetty-launcher-10418-thread-1)
[n:127.0.0.1:55824_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_55824.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@648bbce6
[junit4] 2> 1606444 INFO (jetty-launcher-10418-thread-1)
[n:127.0.0.1:55824_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_55824.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@648bbce6
[junit4] 2> 1606445 INFO (jetty-launcher-10418-thread-1)
[n:127.0.0.1:55824_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_55824.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@648bbce6
[junit4] 2> 1606446 INFO (jetty-launcher-10418-thread-1)
[n:127.0.0.1:55824_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J2\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_472A5CBEEB87541B-001\tempDir-001\node1\.
[junit4] 2> 1606457 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
[junit4] 2> 1606459 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1606461 INFO (zkConnectionManagerCallback-10473-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1606461 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1606462 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1606464 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at
127.0.0.1:55811/solr ready
[junit4] 2> 1606470 INFO (qtp469000159-17701) [n:127.0.0.1:55825_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1606474 INFO (qtp33422634-17698) [n:127.0.0.1:55824_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> 1606480 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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> 1606481 DEBUG (qtp469000159-17699) [n:127.0.0.1:55825_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1606482 INFO (qtp469000159-17699) [n:127.0.0.1:55825_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=8
[junit4] 2> 1606483 DEBUG (zkCallback-10437-thread-1) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
2
[junit4] 2> 1606483 DEBUG
(OverseerAutoScalingTriggerThread-72062954422992902-127.0.0.1:55825_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 2
[junit4] 2> 1606485 INFO (qtp33422634-17702) [n:127.0.0.1:55824_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> 1606485 DEBUG
(OverseerAutoScalingTriggerThread-72062954422992902-127.0.0.1:55825_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1606487 DEBUG
(OverseerAutoScalingTriggerThread-72062954422992902-127.0.0.1:55825_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2,
lastZnodeVersion 2
[junit4] 2> 1606489 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
testScheduledTrigger
[junit4] 2> 1606489 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/managed-schema to
/configs/testScheduledTrigger.AUTOCREATED/managed-schema
[junit4] 2> 1606491 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/protwords.txt to
/configs/testScheduledTrigger.AUTOCREATED/protwords.txt
[junit4] 2> 1606494 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606495 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606497 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606499 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606500 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606502 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606504 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606506 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606508 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606510 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606510 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606513 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606515 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606516 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606518 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606520 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606521 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606523 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606525 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606526 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606528 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606528 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606532 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606533 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606535 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606537 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606538 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606540 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606543 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606544 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606546 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606548 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606549 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606552 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606553 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606555 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606555 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606555 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606555 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606562 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/solrconfig.xml to
/configs/testScheduledTrigger.AUTOCREATED/solrconfig.xml
[junit4] 2> 1606563 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/synonyms.txt to
/configs/testScheduledTrigger.AUTOCREATED/synonyms.txt
[junit4] 2> 1606565 INFO
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/stopwords.txt to
/configs/testScheduledTrigger.AUTOCREATED/stopwords.txt
[junit4] 2> 1606696 WARN
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_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> 1606697 DEBUG
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_solr ] o.a.s.c.s.c.a.PolicyHelper Creating a new session
[junit4] 2> 1606700 INFO (qtp33422634-17696) [n:127.0.0.1:55824_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> 1606701 INFO (qtp469000159-17701) [n:127.0.0.1:55825_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> 1606704 DEBUG
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_solr ] o.a.s.c.s.c.a.PolicyHelper New session created
[junit4] 2> 1606706 INFO (qtp33422634-17698) [n:127.0.0.1:55824_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> 1606710 INFO (qtp469000159-17703) [n:127.0.0.1:55825_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> 1606712 DEBUG
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_solr ] o.a.s.c.s.c.a.PolicyHelper returnSession,
curr-time 81794100 sessionWrapper.createTime 81794093722300,
this.sessionWrapper.createTime 81794093722300
[junit4] 2> 1606717 INFO
(OverseerStateUpdate-72062954422992902-127.0.0.1:55825_solr-n_0000000000)
[n:127.0.0.1:55825_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testScheduledTrigger",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testScheduledTrigger_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:55825/solr";,
[junit4] 2> "node_name":"127.0.0.1:55825_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1606719 INFO
(OverseerStateUpdate-72062954422992902-127.0.0.1:55825_solr-n_0000000000)
[n:127.0.0.1:55825_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testScheduledTrigger",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testScheduledTrigger_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:55824/solr";,
[junit4] 2> "node_name":"127.0.0.1:55824_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1606722 INFO
(OverseerStateUpdate-72062954422992902-127.0.0.1:55825_solr-n_0000000000)
[n:127.0.0.1:55825_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testScheduledTrigger",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testScheduledTrigger_shard1_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:55824/solr";,
[junit4] 2> "node_name":"127.0.0.1:55824_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1606981 INFO (qtp33422634-17700) [n:127.0.0.1:55824_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> 1606981 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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> 1606982 INFO (qtp469000159-17697) [n:127.0.0.1:55825_solr
x:testScheduledTrigger_shard1_replica_n1 ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 1606982 INFO (qtp33422634-17698) [n:127.0.0.1:55824_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> 1607000 INFO (qtp469000159-17697) [n:127.0.0.1:55825_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 8.6.0
[junit4] 2> 1607000 INFO (qtp33422634-17698) [n:127.0.0.1:55824_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 8.6.0
[junit4] 2> 1607000 INFO (qtp33422634-17700) [n:127.0.0.1:55824_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 8.6.0
[junit4] 2> 1607038 INFO (qtp469000159-17697) [n:127.0.0.1:55825_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1607038 INFO (qtp33422634-17700) [n:127.0.0.1:55824_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1607040 INFO (qtp33422634-17698) [n:127.0.0.1:55824_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1607254 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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> 1607259 INFO (qtp33422634-17698) [n:127.0.0.1:55824_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> 1607259 INFO (qtp33422634-17700) [n:127.0.0.1:55824_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> 1607317 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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> 1607319 INFO (qtp469000159-17697) [n:127.0.0.1:55825_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_55825.solr.core.testScheduledTrigger.shard1.replica_n1'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n1') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@648bbce6
[junit4] 2> 1607320 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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-8.x-Windows\solr\build\solr-core\test\J2\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_472A5CBEEB87541B-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J2\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_472A5CBEEB87541B-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n1\data\]
[junit4] 2> 1607328 INFO (qtp33422634-17698) [n:127.0.0.1:55824_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> 1607329 INFO (qtp33422634-17698) [n:127.0.0.1:55824_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_55824.solr.core.testScheduledTrigger.shard1.replica_n2'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n2') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@648bbce6
[junit4] 2> 1607329 INFO (qtp33422634-17698) [n:127.0.0.1:55824_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-8.x-Windows\solr\build\solr-core\test\J2\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_472A5CBEEB87541B-001\tempDir-001\node1\.\testScheduledTrigger_shard1_replica_n2],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J2\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_472A5CBEEB87541B-001\tempDir-001\node1\.\testScheduledTrigger_shard1_replica_n2\data\]
[junit4] 2> 1607330 INFO (qtp33422634-17700) [n:127.0.0.1:55824_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> 1607330 INFO (qtp33422634-17700) [n:127.0.0.1:55824_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_55824.solr.core.testScheduledTrigger.shard1.replica_n4'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n4') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@648bbce6
[junit4] 2> 1607330 INFO (qtp33422634-17700) [n:127.0.0.1:55824_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-8.x-Windows\solr\build\solr-core\test\J2\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_472A5CBEEB87541B-001\tempDir-001\node1\.\testScheduledTrigger_shard1_replica_n4],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J2\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_472A5CBEEB87541B-001\tempDir-001\node1\.\testScheduledTrigger_shard1_replica_n4\data\]
[junit4] 2> 1607423 DEBUG (ScheduledTrigger-10443-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> 1607429 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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> 1607429 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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> 1607432 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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> 1607432 INFO (qtp469000159-17697) [n:127.0.0.1:55825_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1607434 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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> 1607434 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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> 1607434 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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> 1607435 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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> 1607435 INFO (qtp469000159-17697) [n:127.0.0.1:55825_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1607436 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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> 1607436 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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> 1607436 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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 1667014042573602816
[junit4] 2> 1607439 INFO
(searcherExecutor-10475-thread-1-processing-n:127.0.0.1:55825_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:55825_solr c:testScheduledTrigger s:shard1
r:core_node3 x:testScheduledTrigger_shard1_replica_n1 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1607439 INFO
(searcherExecutor-10475-thread-1-processing-n:127.0.0.1:55825_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:55825_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> 1607439 INFO
(searcherExecutor-10475-thread-1-processing-n:127.0.0.1:55825_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:55825_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> 1607440 INFO (qtp33422634-17698) [n:127.0.0.1:55824_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> 1607440 INFO (qtp33422634-17698) [n:127.0.0.1:55824_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> 1607442 INFO (qtp469000159-17697) [n:127.0.0.1:55825_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful
update of terms at /collections/testScheduledTrigger/terms/shard1 to
Terms{values={core_node3=0}, version=0}
[junit4] 2> 1607442 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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> 1607444 INFO (qtp33422634-17698) [n:127.0.0.1:55824_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> 1607444 INFO (qtp33422634-17698) [n:127.0.0.1:55824_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1607445 INFO (qtp33422634-17698) [n:127.0.0.1:55824_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> 1607446 INFO (qtp33422634-17698) [n:127.0.0.1:55824_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> 1607446 INFO (qtp33422634-17698) [n:127.0.0.1:55824_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> 1607447 INFO (qtp33422634-17698) [n:127.0.0.1:55824_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> 1607448 INFO (qtp33422634-17700) [n:127.0.0.1:55824_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> 1607448 INFO (qtp33422634-17700) [n:127.0.0.1:55824_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> 1607448 INFO (qtp33422634-17698) [n:127.0.0.1:55824_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1607448 INFO (qtp33422634-17698) [n:127.0.0.1:55824_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> 1607448 INFO (qtp469000159-17697) [n:127.0.0.1:55825_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext
Waiting until we see more replicas up for shard shard1: total=3 found=1
timeoute in=9999ms
[junit4] 2> 1607449 INFO (qtp33422634-17698) [n:127.0.0.1:55824_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> 1607449 INFO (qtp33422634-17698) [n:127.0.0.1:55824_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 1667014042587234304
[junit4] 2> 1607450 INFO (qtp33422634-17700) [n:127.0.0.1:55824_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> 1607450 INFO (qtp33422634-17700) [n:127.0.0.1:55824_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1607451 INFO
(searcherExecutor-10477-thread-1-processing-n:127.0.0.1:55824_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:55824_solr c:testScheduledTrigger s:shard1
r:core_node5 x:testScheduledTrigger_shard1_replica_n2 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1607451 INFO
(searcherExecutor-10477-thread-1-processing-n:127.0.0.1:55824_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:55824_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> 1607451 INFO
(searcherExecutor-10477-thread-1-processing-n:127.0.0.1:55824_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:55824_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> 1607452 INFO (qtp33422634-17700) [n:127.0.0.1:55824_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> 1607453 INFO (qtp33422634-17700) [n:127.0.0.1:55824_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> 1607453 INFO (qtp33422634-17700) [n:127.0.0.1:55824_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> 1607453 INFO (qtp33422634-17700) [n:127.0.0.1:55824_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> 1607454 INFO (qtp33422634-17700) [n:127.0.0.1:55824_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1607454 INFO (qtp33422634-17700) [n:127.0.0.1:55824_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> 1607454 INFO (qtp33422634-17698) [n:127.0.0.1:55824_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.ZkShardTerms Successful
update of terms at /collections/testScheduledTrigger/terms/shard1 to
Terms{values={core_node3=0, core_node5=0}, version=1}
[junit4] 2> 1607454 INFO (qtp33422634-17698) [n:127.0.0.1:55824_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> 1607455 INFO (qtp33422634-17700) [n:127.0.0.1:55824_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> 1607455 INFO (qtp33422634-17700) [n:127.0.0.1:55824_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 1667014042593525760
[junit4] 2> 1607455 INFO
(searcherExecutor-10479-thread-1-processing-n:127.0.0.1:55824_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:55824_solr c:testScheduledTrigger s:shard1
r:core_node6 x:testScheduledTrigger_shard1_replica_n4 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1607455 INFO
(searcherExecutor-10479-thread-1-processing-n:127.0.0.1:55824_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:55824_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> 1607455 INFO
(searcherExecutor-10479-thread-1-processing-n:127.0.0.1:55824_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:55824_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> 1607457 INFO (qtp33422634-17700) [n:127.0.0.1:55824_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> 1607458 INFO (qtp33422634-17700) [n:127.0.0.1:55824_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> 1608079 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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> 1608079 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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> 1608079 INFO (qtp469000159-17697) [n:127.0.0.1:55825_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas
to http://127.0.0.1:55825/solr/testScheduledTrigger_shard1_replica_n1/
[junit4] 2> 1608080 INFO (qtp469000159-17697) [n:127.0.0.1:55825_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.PeerSync PeerSync:
core=testScheduledTrigger_shard1_replica_n1 url=http://127.0.0.1:55825/solr
START
replicas=[http://127.0.0.1:55824/solr/testScheduledTrigger_shard1_replica_n2/,
http://127.0.0.1:55824/solr/testScheduledTrigger_shard1_replica_n4/]
nUpdates=100
[junit4] 2> 1608081 INFO (qtp469000159-17697) [n:127.0.0.1:55825_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.PeerSync PeerSync:
core=testScheduledTrigger_shard1_replica_n1 url=http://127.0.0.1:55825/solr
DONE. We have no versions. sync failed.
[junit4] 2> 1608082 INFO (qtp33422634-17696) [n:127.0.0.1:55824_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> 1608082 INFO (qtp33422634-17771) [n:127.0.0.1:55824_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> 1608083 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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> 1608083 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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> 1608083 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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/72062954422992902-core_node3-n_0000000000
[junit4] 2> 1608086 INFO (qtp469000159-17697) [n:127.0.0.1:55825_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I
am the new leader:
http://127.0.0.1:55825/solr/testScheduledTrigger_shard1_replica_n1/ shard1
[junit4] 2> 1608214 INFO (zkCallback-10437-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> 1608214 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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> 1608220 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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=983
[junit4] 2> 1608343 INFO (zkCallback-10437-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> 1608343 INFO (zkCallback-10437-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> 1608683 DEBUG (ScheduledTrigger-10443-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> 1608723 INFO (qtp33422634-17700) [n:127.0.0.1:55824_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=1384
[junit4] 2> 1608723 INFO (qtp33422634-17698) [n:127.0.0.1:55824_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=1383
[junit4] 2> 1608723 DEBUG
(OverseerThreadFactory-10445-thread-1-processing-n:127.0.0.1:55825_solr)
[n:127.0.0.1:55825_solr ] o.a.s.c.s.c.a.PolicyHelper session set to NULL
[junit4] 2> 1608726 INFO (qtp33422634-17702) [n:127.0.0.1:55824_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> 1608839 INFO (zkCallback-10459-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> 1608839 INFO (zkCallback-10437-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> 1608839 INFO (zkCallback-10437-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> 1608839 INFO (zkCallback-10459-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> 1608840 INFO (qtp33422634-17702) [n:127.0.0.1:55824_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=1878
[junit4] 2> 1608840 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection:
testScheduledTrigger
[junit4] 2> 1608844 INFO (qtp33422634-17696) [n:127.0.0.1:55824_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> 1608847 INFO (qtp33422634-17771) [n:127.0.0.1:55824_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> 1608848 INFO (qtp469000159-17703) [n:127.0.0.1:55825_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> 1608850 INFO (qtp469000159-17697) [n:127.0.0.1:55825_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> 1608850 DEBUG (qtp469000159-17701) [n:127.0.0.1:55825_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1608851 INFO (qtp469000159-17701) [n:127.0.0.1:55825_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=7
[junit4] 2> 1608851 DEBUG (zkCallback-10437-thread-2) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
3
[junit4] 2> 1608851 DEBUG
(OverseerAutoScalingTriggerThread-72062954422992902-127.0.0.1:55825_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 3
[junit4] 2> 1608852 DEBUG
(OverseerAutoScalingTriggerThread-72062954422992902-127.0.0.1:55825_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1608852 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short
content, break even is size 23
[junit4] 2> 1608852 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding
port=0)
[junit4] 2> 1608852 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number
2 ...
[junit4] 2> 1608852 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.e.j.s.Server jetty-9.4.27.v20200227; built:
2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm
11.0.6+10
[junit4] 2> 1608853 DEBUG
(OverseerAutoScalingTriggerThread-72062954422992902-127.0.0.1:55825_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3,
lastZnodeVersion 3
[junit4] 2> 1608853 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1608853 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1608853 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1608853 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@d280eac{/solr,null,AVAILABLE}
[junit4] 2> 1608855 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.e.j.s.AbstractConnector Started ServerConnector@22d6266f{HTTP/1.1,
(http/1.1, h2c)}{127.0.0.1:55912}
[junit4] 2> 1608855 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.e.j.s.Server Started @1545727ms
[junit4] 2> 1608855 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=55912}
[junit4] 2> 1608855 ERROR
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging
may be missing or incomplete.
[junit4] 2> 1608855 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1608855 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™
version 8.6.0
[junit4] 2> 1608855 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on
port null
[junit4] 2> 1608855 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr
[junit4] 2> 1608855 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-05-18T07:54:38.910564200Z
[junit4] 2> 1608856 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1608858 INFO (zkConnectionManagerCallback-10493-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1608858 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1608859 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1608982 INFO
(OverseerCollectionConfigSetProcessor-72062954422992902-127.0.0.1:55825_solr-n_0000000000)
[n:127.0.0.1:55825_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 1609117 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1609118 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.e.j.u.s.S.config Trusting all certificates configured for
Client@75c0ad2e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1609118 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm
configured for Client@75c0ad2e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1609122 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.e.j.u.s.S.config Trusting all certificates configured for
Client@7ba0eec3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1609122 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm
configured for Client@7ba0eec3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1609123 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:55811/solr
[junit4] 2> 1609123 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1609126 INFO (zkConnectionManagerCallback-10504-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1609126 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1609241 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[n:127.0.0.1:55912_solr ] o.a.s.c.c.ConnectionManager Waiting for client
to connect to ZooKeeper
[junit4] 2> 1609243 INFO (zkConnectionManagerCallback-10506-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1609243 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[n:127.0.0.1:55912_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1609249 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[n:127.0.0.1:55912_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 1609252 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[n:127.0.0.1:55912_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:55912_solr as DOWN
[junit4] 2> 1609253 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[n:127.0.0.1:55912_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 1609253 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[n:127.0.0.1:55912_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:55912_solr
[junit4] 2> 1609254 INFO (zkCallback-10437-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1609254 INFO (zkCallback-10472-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1609254 INFO (zkCallback-10459-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1609254 INFO (zkCallback-10505-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1609255 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[n:127.0.0.1:55912_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1609256 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[n:127.0.0.1:55912_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> 1609280 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[n:127.0.0.1:55912_solr ] o.a.s.h.a.Met
[...truncated too long message...]
r@36d15c0e: rootName = solr_55824, domain = solr.jvm, service url = null, agent
id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@4390456f
[junit4] 2> 1651927 INFO (jetty-closer-10515-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty
tag=null
[junit4] 2> 1651927 INFO (jetty-closer-10515-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@6a6e1eed: rootName =
solr_55824, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty/com.codahale.metrics.MetricRegistry@39b7ac88
[junit4] 2> 1651927 INFO (jetty-closer-10515-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster
tag=null
[junit4] 2> 1651986 INFO (jetty-closer-10515-thread-3) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@22d6266f{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 1651986 INFO (jetty-closer-10515-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@d280eac{/solr,null,UNAVAILABLE}
[junit4] 2> 1651986 INFO (jetty-closer-10515-thread-3) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1652060 INFO (jetty-closer-10515-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@f3a0365{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 1652060 INFO (jetty-closer-10515-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@ed7256e{/solr,null,UNAVAILABLE}
[junit4] 2> 1652060 INFO (jetty-closer-10515-thread-2) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1652134 INFO (jetty-closer-10515-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72062954422992902-127.0.0.1:55825_solr-n_0000000000) closing
[junit4] 2> 1652135 INFO (jetty-closer-10515-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@1533b2d1{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 1652135 INFO (jetty-closer-10515-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@3553a005{/solr,null,UNAVAILABLE}
[junit4] 2> 1652136 INFO (jetty-closer-10515-thread-1) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1652136 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 1652287 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> 7
/solr/collections/testScheduledTrigger/terms/shard1
[junit4] 2> 4 /solr/aliases.json
[junit4] 2> 4 /solr/clusterprops.json
[junit4] 2> 3
/solr/configs/testScheduledTrigger.AUTOCREATED/managed-schema
[junit4] 2> 3 /solr/packages.json
[junit4] 2> 3 /solr/security.json
[junit4] 2> 2 /solr/configs/testScheduledTrigger.AUTOCREATED
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 21
/solr/collections/testScheduledTrigger/state.json
[junit4] 2> 4 /solr/clusterstate.json
[junit4] 2> 4 /solr/autoscaling.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 23 /solr/overseer/queue
[junit4] 2> 14 /solr/live_nodes
[junit4] 2> 7 /solr/collections
[junit4] 2> 5 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> 1652290 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:55811
[junit4] 2> 1652290 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:55811
[junit4] 2> 1652290 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 55811
[junit4] 2> 1653780 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[472A5CBEEB87541B])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testScheduledTrigger
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=ScheduledTriggerIntegrationTest -Dtests.method=testScheduledTrigger
-Dtests.seed=472A5CBEEB87541B -Dtests.slow=true -Dtests.locale=mas
-Dtests.timezone=America/Noronha -Dtests.asserts=true
-Dtests.file.encoding=Cp1252
[junit4] FAILURE 48.5s J2 |
ScheduledTriggerIntegrationTest.testScheduledTrigger <<<
[junit4] > Throwable #1: java.lang.AssertionError: ScheduledTrigger did
not fire in time
[junit4] > at
__randomizedtesting.SeedInfo.seed([472A5CBEEB87541B:D43114CCB57A0F2F]: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:566)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:834)
[junit4] 2> NOTE: leaving temporary files on disk at:
C:\Users\jenkins\workspace\Lucene-Solr-8.x-Windows\solr\build\solr-core\test\J2\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_472A5CBEEB87541B-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene84): {},
docValues:{}, maxPointsInLeafNode=111, maxMBSortInHeap=5.858190133717641,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@5a8fcbef),
locale=mas, timezone=America/Noronha
[junit4] 2> NOTE: Windows 10 10.0 amd64/AdoptOpenJDK 11.0.6
(64-bit)/cpus=6,threads=1,free=215639968,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [MetricTriggerTest,
TestSolrJ, TestCaffeineCache, CoreSorterTest, TestExportWriter,
BlockJoinFacetSimpleTest, MaxSizeAutoCommitTest, SuggesterFSTTest,
ActionThrottleTest, DistributedVersionInfoTest, SystemCollectionCompatTest,
TestPartialUpdateDeduplication, TestTermsQParserPlugin, TestConfigsApi,
TestPerFieldSimilarity, SolrMetricsIntegrationTest, JvmMetricsTest,
TestRandomFaceting, TestCopyFieldCollectionResource, HLLUtilTest,
StressHdfsTest, TestDynamicLoading, TestReRankQParserPlugin,
PreAnalyzedUpdateProcessorTest, HdfsSyncSliceTest, ClusterStateTest,
TestHashQParserPlugin, TestPullReplicaErrorHandling, ZkControllerTest,
SaslZkACLProviderTest, PeerSyncWithLeaderTest, SchemaApiFailureTest,
IndexSchemaTest, CdcrBootstrapTest, TestOmitPositions, JWTAuthPluginTest,
MoreLikeThisHandlerTest, TestAnalyzedSuggestions,
NestedShardedAtomicUpdateTest, SuggestComponentContextFilterQueryTest,
LegacyCloudClusterPropTest, BigEndianAscendingWordSerializerTest,
TestSQLHandlerNonCloud, TestCustomDocTransformer, ConvertedLegacyTest,
TestNestedUpdateProcessor, TestCryptoKeys, InfixSuggestersTest,
TestLegacyFieldCache, TestCloudPhrasesIdentificationComponent, TestPushWriter,
TestMacros, TestReloadDeadlock, TestJsonRangeFacets,
TestTolerantUpdateProcessorRandomCloud, HdfsChaosMonkeySafeLeaderTest,
OverseerTaskQueueTest, LargeFieldTest, TaggerTest,
TestUnifiedSolrHighlighterWithoutStoredId, AutoscalingHistoryHandlerTest,
ReturnFieldsTest, TestSortableTextField, SpellCheckCollatorWithCollapseTest,
DistributedQueryElevationComponentTest, DirectSolrConnectionTest,
TestSimDistribStateManager, BasicDistributedZkTest, DeleteInactiveReplicaTest,
UniqFieldsUpdateProcessorFactoryTest, TestFieldTypeCollectionResource,
TestSkipOverseerOperations, TestCloudSearcherWarming,
TestDynamicFieldNamesIndexCorrectly, MoveReplicaHDFSFailoverTest,
MinimalSchemaTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest,
SolrLogAuditLoggerPluginTest, TestBinaryField, AutoAddReplicasPlanActionTest,
LoggingHandlerTest, TestHdfsCloudBackupRestore, SolrCLIZkUtilsTest,
DocValuesMultiTest, TestSimLargeCluster, AuditLoggerPluginTest,
V2ApiIntegrationTest, TestCSVLoader, HttpPartitionOnCommitTest,
TestDistributedSearch, ConnectionManagerTest, DeleteShardTest,
DeleteStatusTest, LeaderElectionIntegrationTest,
LeaderFailureAfterFreshStartTest, RecoveryAfterSoftCommitTest,
RemoteQueryErrorTest, ReplicationFactorTest,
TestWaitForStateWithJettyShutdowns, TestZkChroot, AssignTest,
CollectionsAPIAsyncDistributedZkTest, TestLocalFSCloudBackupRestore,
ComputePlanActionTest, NodeMarkersRegistrationTest,
ScheduledTriggerIntegrationTest]
[junit4] Completed [582/908 (1!)] on J2 in 48.62s, 1 test, 1 failure <<<
FAILURES!
[...truncated 48956 lines...]
[repro] Jenkins log URL:
https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Windows/1140/consoleText
[repro] Revision: 62847cced885fd8b2402b9adc588247340d16f41
[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseSerialGC"
[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 3484 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5
-Dtests.class="*.ScheduledTriggerIntegrationTest" -Dtests.showOutput=onerror
"-Dargs=-XX:-UseCompressedOops -XX:+UseSerialGC" -Dtests.seed=472A5CBEEB87541B
-Dtests.slow=true -Dtests.locale=mas -Dtests.timezone=America/Noronha
-Dtests.asserts=true -Dtests.file.encoding=Cp1252
[...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]
