Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/8865/
Java: 64bit/jdk-12.0.2 -XX:-UseCompressedOops -XX:+UseG1GC
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([7C1E5F7ED8AF67CD:EF05170C86523CF9]: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:567)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
at java.base/java.lang.Thread.run(Thread.java:835)
Build Log:
[...truncated 14953 lines...]
[junit4] Suite:
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest
[junit4] 2> 1615675 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[7C1E5F7ED8AF67CD]-worker) [ ]
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to
test-framework derived value of
'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\server\solr\configsets\_default\conf'
[junit4] 2> 1615675 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[7C1E5F7ED8AF67CD]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1615676 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[7C1E5F7ED8AF67CD]-worker) [ ]
o.a.s.SolrTestCaseJ4 Created dataDir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_7C1E5F7ED8AF67CD-001\data-dir-153-001
[junit4] 2> 1615677 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[7C1E5F7ED8AF67CD]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1615678 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[7C1E5F7ED8AF67CD]-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> 1615680 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testScheduledTrigger
[junit4] 2> 1615682 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_7C1E5F7ED8AF67CD-001\tempDir-001
[junit4] 2> 1615682 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1615683 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 1615683 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1615774 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.ZkTestServer start zk server on port: 60481
[junit4] 2> 1615774 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:60481
[junit4] 2> 1615774 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:60481
[junit4] 2> 1615774 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 60481
[junit4] 2> 1615776 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1615780 INFO (zkConnectionManagerCallback-14036-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1615780 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1615783 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1615786 INFO (zkConnectionManagerCallback-14038-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1615786 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1615787 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1615788 INFO (zkConnectionManagerCallback-14040-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1615788 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1615883 INFO (jetty-launcher-14041-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1615883 INFO (jetty-launcher-14041-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1615883 INFO (jetty-launcher-14041-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1615883 INFO (jetty-launcher-14041-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1615883 INFO (jetty-launcher-14041-thread-2) [ ]
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git:
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 12.0.2+10
[junit4] 2> 1615883 INFO (jetty-launcher-14041-thread-1) [ ]
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git:
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 12.0.2+10
[junit4] 2> 1615884 INFO (jetty-launcher-14041-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1615884 INFO (jetty-launcher-14041-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1615884 INFO (jetty-launcher-14041-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1615884 INFO (jetty-launcher-14041-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@19df298f{/solr,null,AVAILABLE}
[junit4] 2> 1615885 INFO (jetty-launcher-14041-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1615885 INFO (jetty-launcher-14041-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1615885 INFO (jetty-launcher-14041-thread-2) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1615886 INFO (jetty-launcher-14041-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@5b4323ff{/solr,null,AVAILABLE}
[junit4] 2> 1615886 INFO (jetty-launcher-14041-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@2d4d2181{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:60494}
[junit4] 2> 1615886 INFO (jetty-launcher-14041-thread-1) [ ]
o.e.j.s.Server Started @1554112ms
[junit4] 2> 1615886 INFO (jetty-launcher-14041-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=60494}
[junit4] 2> 1615886 ERROR (jetty-launcher-14041-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1615886 INFO (jetty-launcher-14041-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1615886 INFO (jetty-launcher-14041-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
9.0.0
[junit4] 2> 1615886 INFO (jetty-launcher-14041-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1615886 INFO (jetty-launcher-14041-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
[junit4] 2> 1615886 INFO (jetty-launcher-14041-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-05-22T09:48:28.373638500Z
[junit4] 2> 1615887 INFO (jetty-launcher-14041-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@4ad3c68d{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:60501}
[junit4] 2> 1615887 INFO (jetty-launcher-14041-thread-2) [ ]
o.e.j.s.Server Started @1554114ms
[junit4] 2> 1615887 INFO (jetty-launcher-14041-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=60501}
[junit4] 2> 1615887 INFO (jetty-launcher-14041-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1615887 ERROR (jetty-launcher-14041-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1615887 INFO (jetty-launcher-14041-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1615887 INFO (jetty-launcher-14041-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
9.0.0
[junit4] 2> 1615887 INFO (jetty-launcher-14041-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1615887 INFO (jetty-launcher-14041-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
[junit4] 2> 1615887 INFO (jetty-launcher-14041-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-05-22T09:48:28.374129200Z
[junit4] 2> 1615887 INFO (jetty-launcher-14041-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1615887 INFO (zkConnectionManagerCallback-14043-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1615887 INFO (jetty-launcher-14041-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1615887 INFO (jetty-launcher-14041-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1615887 INFO (zkConnectionManagerCallback-14045-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1615887 INFO (jetty-launcher-14041-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1615890 INFO (jetty-launcher-14041-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1615991 INFO (jetty-launcher-14041-thread-2) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1615992 WARN (jetty-launcher-14041-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@72316aad[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1615992 WARN (jetty-launcher-14041-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@72316aad[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1615995 WARN (jetty-launcher-14041-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@43ae2c39[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1615995 WARN (jetty-launcher-14041-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@43ae2c39[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1615996 INFO (jetty-launcher-14041-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:60481/solr
[junit4] 2> 1615998 INFO (jetty-launcher-14041-thread-2)
[n:127.0.0.1:60501_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1615999 INFO (zkConnectionManagerCallback-14056-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1615999 INFO (jetty-launcher-14041-thread-2)
[n:127.0.0.1:60501_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1616073 INFO (jetty-launcher-14041-thread-2)
[n:127.0.0.1:60501_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:60501_solr
[junit4] 2> 1616073 INFO (jetty-launcher-14041-thread-2)
[n:127.0.0.1:60501_solr ] o.a.s.c.Overseer Overseer
(id=72085263852109829-127.0.0.1:60501_solr-n_0000000000) starting
[junit4] 2> 1616078 INFO (jetty-launcher-14041-thread-2)
[n:127.0.0.1:60501_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:60501_solr
[junit4] 2> 1616078 INFO
(OverseerStateUpdate-72085263852109829-127.0.0.1:60501_solr-n_0000000000)
[n:127.0.0.1:60501_solr ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:60501_solr
[junit4] 2> 1616078 DEBUG
(OverseerAutoScalingTriggerThread-72085263852109829-127.0.0.1:60501_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and
.scheduled_maintenance triggers
[junit4] 2> 1616079 INFO
(OverseerStateUpdate-72085263852109829-127.0.0.1:60501_solr-n_0000000000)
[n:127.0.0.1:60501_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1616079 DEBUG
(OverseerAutoScalingTriggerThread-72085263852109829-127.0.0.1:60501_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with
znode version 1
[junit4] 2> 1616079 DEBUG
(OverseerAutoScalingTriggerThread-72085263852109829-127.0.0.1:60501_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1,
lastZnodeVersion 0
[junit4] 2> 1616079 DEBUG
(OverseerAutoScalingTriggerThread-72085263852109829-127.0.0.1:60501_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 1
[junit4] 2> 1616079 INFO (jetty-launcher-14041-thread-2)
[n:127.0.0.1:60501_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1616080 WARN (jetty-launcher-14041-thread-2)
[n:127.0.0.1:60501_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> 1616082 DEBUG
(OverseerAutoScalingTriggerThread-72085263852109829-127.0.0.1:60501_solr-n_0000000000)
[ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial
livenodes: [127.0.0.1:60501_solr]
[junit4] 2> 1616082 INFO (jetty-launcher-14041-thread-1) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1616082 DEBUG
(OverseerAutoScalingTriggerThread-72085263852109829-127.0.0.1:60501_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1616083 DEBUG (ScheduledTrigger-14061-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> 1616083 DEBUG
(OverseerAutoScalingTriggerThread-72085263852109829-127.0.0.1:60501_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1,
lastZnodeVersion 1
[junit4] 2> 1616083 WARN (jetty-launcher-14041-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@4df0747d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1616083 WARN (jetty-launcher-14041-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@4df0747d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1616086 WARN (jetty-launcher-14041-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@638a6eab[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1616086 WARN (jetty-launcher-14041-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@638a6eab[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1616087 INFO (jetty-launcher-14041-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:60481/solr
[junit4] 2> 1616088 INFO (jetty-launcher-14041-thread-1)
[n:127.0.0.1:60494_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1616089 INFO (zkConnectionManagerCallback-14074-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1616089 INFO (jetty-launcher-14041-thread-1)
[n:127.0.0.1:60494_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1616093 INFO (jetty-launcher-14041-thread-1)
[n:127.0.0.1:60494_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1616095 INFO (jetty-launcher-14041-thread-1)
[n:127.0.0.1:60494_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:60494_solr as DOWN
[junit4] 2> 1616095 INFO (jetty-launcher-14041-thread-1)
[n:127.0.0.1:60494_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 1000 transient cores
[junit4] 2> 1616095 INFO (jetty-launcher-14041-thread-1)
[n:127.0.0.1:60494_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:60494_solr
[junit4] 2> 1616097 INFO (zkCallback-14055-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1616097 INFO (zkCallback-14073-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1616098 INFO (jetty-launcher-14041-thread-1)
[n:127.0.0.1:60494_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1616098 WARN (jetty-launcher-14041-thread-1)
[n:127.0.0.1:60494_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> 1616098 INFO (jetty-launcher-14041-thread-2)
[n:127.0.0.1:60501_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1616120 INFO (jetty-launcher-14041-thread-1)
[n:127.0.0.1:60494_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1616123 INFO (jetty-launcher-14041-thread-2)
[n:127.0.0.1:60501_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_60501.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@26755773
[junit4] 2> 1616130 INFO (jetty-launcher-14041-thread-2)
[n:127.0.0.1:60501_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_60501.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@26755773
[junit4] 2> 1616131 INFO (jetty-launcher-14041-thread-2)
[n:127.0.0.1:60501_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_60501.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@26755773
[junit4] 2> 1616131 INFO (jetty-launcher-14041-thread-2)
[n:127.0.0.1:60501_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_7C1E5F7ED8AF67CD-001\tempDir-001\node2\.
[junit4] 2> 1616140 INFO (jetty-launcher-14041-thread-1)
[n:127.0.0.1:60494_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_60494.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@26755773
[junit4] 2> 1616146 INFO (jetty-launcher-14041-thread-1)
[n:127.0.0.1:60494_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_60494.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@26755773
[junit4] 2> 1616146 INFO (jetty-launcher-14041-thread-1)
[n:127.0.0.1:60494_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_60494.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@26755773
[junit4] 2> 1616148 INFO (jetty-launcher-14041-thread-1)
[n:127.0.0.1:60494_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_7C1E5F7ED8AF67CD-001\tempDir-001\node1\.
[junit4] 2> 1616159 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
[junit4] 2> 1616160 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1616163 INFO (zkConnectionManagerCallback-14092-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1616163 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1616163 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1616165 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at
127.0.0.1:60481/solr ready
[junit4] 2> 1616172 INFO (qtp1142173823-22929) [n:127.0.0.1:60501_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1616177 INFO (qtp596302720-22924) [n:127.0.0.1:60494_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=2
[junit4] 2> 1616178 INFO (qtp1142173823-22930) [n:127.0.0.1:60501_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 1000
transient cores
[junit4] 2> 1616181 INFO (qtp1142173823-22930) [n:127.0.0.1:60501_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=2
[junit4] 2> 1616181 DEBUG (qtp596302720-22923) [n:127.0.0.1:60494_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1616182 INFO (qtp596302720-22923) [n:127.0.0.1:60494_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=9
[junit4] 2> 1616182 DEBUG (zkCallback-14055-thread-1) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
2
[junit4] 2> 1616183 DEBUG
(OverseerAutoScalingTriggerThread-72085263852109829-127.0.0.1:60501_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 2
[junit4] 2> 1616183 INFO (qtp596302720-22925) [n:127.0.0.1:60494_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> 1616183 DEBUG
(OverseerAutoScalingTriggerThread-72085263852109829-127.0.0.1:60501_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1616183 DEBUG
(OverseerAutoScalingTriggerThread-72085263852109829-127.0.0.1:60501_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2,
lastZnodeVersion 2
[junit4] 2> 1616183 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
testScheduledTrigger
[junit4] 2> 1616187 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/managed-schema to
/configs/testScheduledTrigger.AUTOCREATED/managed-schema
[junit4] 2> 1616189 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/protwords.txt to
/configs/testScheduledTrigger.AUTOCREATED/protwords.txt
[junit4] 2> 1616190 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616192 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616193 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616194 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616195 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616197 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616198 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616200 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616201 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616203 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616204 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616205 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616207 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616208 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616210 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616210 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616212 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616213 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616215 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616216 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616217 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616218 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616220 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616221 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616223 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616224 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616225 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616226 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616228 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616229 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616231 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616232 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616233 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616235 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616241 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616242 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616244 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616245 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616247 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616248 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/solrconfig.xml to
/configs/testScheduledTrigger.AUTOCREATED/solrconfig.xml
[junit4] 2> 1616250 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/synonyms.txt to
/configs/testScheduledTrigger.AUTOCREATED/synonyms.txt
[junit4] 2> 1616252 INFO
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/stopwords.txt to
/configs/testScheduledTrigger.AUTOCREATED/stopwords.txt
[junit4] 2> 1616348 WARN
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_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> 1616349 DEBUG
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_solr ] o.a.s.c.s.c.a.PolicyHelper Creating a new session
[junit4] 2> 1616352 INFO (qtp596302720-22924) [n:127.0.0.1:60494_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=3
[junit4] 2> 1616356 INFO (qtp1142173823-22927) [n:127.0.0.1:60501_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=2
[junit4] 2> 1616356 DEBUG
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_solr ] o.a.s.c.s.c.a.PolicyHelper New session created
[junit4] 2> 1616359 INFO (qtp596302720-22923) [n:127.0.0.1:60494_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=2
[junit4] 2> 1616362 INFO (qtp1142173823-22929) [n:127.0.0.1:60501_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=2
[junit4] 2> 1616364 DEBUG
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_solr ] o.a.s.c.s.c.a.PolicyHelper returnSession,
curr-time 422208596 sessionWrapper.createTime 422208587610900,
this.sessionWrapper.createTime 422208587610900
[junit4] 2> 1616367 INFO
(OverseerStateUpdate-72085263852109829-127.0.0.1:60501_solr-n_0000000000)
[n:127.0.0.1:60501_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:60501/solr";,
[junit4] 2> "node_name":"127.0.0.1:60501_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1616369 INFO
(OverseerStateUpdate-72085263852109829-127.0.0.1:60501_solr-n_0000000000)
[n:127.0.0.1:60501_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:60494/solr";,
[junit4] 2> "node_name":"127.0.0.1:60494_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1616371 INFO
(OverseerStateUpdate-72085263852109829-127.0.0.1:60501_solr-n_0000000000)
[n:127.0.0.1:60501_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:60494/solr";,
[junit4] 2> "node_name":"127.0.0.1:60494_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1616557 INFO (qtp596302720-22921) [n:127.0.0.1:60494_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> 1616557 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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> 1616561 INFO (qtp596302720-22924) [n:127.0.0.1:60494_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> 1616589 INFO (qtp596302720-22921) [n:127.0.0.1:60494_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 9.0.0
[junit4] 2> 1616590 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 9.0.0
[junit4] 2> 1616594 INFO (qtp596302720-22924) [n:127.0.0.1:60494_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 9.0.0
[junit4] 2> 1616610 INFO (qtp596302720-22921) [n:127.0.0.1:60494_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1616610 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1616615 INFO (qtp596302720-22924) [n:127.0.0.1:60494_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1616829 INFO (qtp596302720-22921) [n:127.0.0.1:60494_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> 1616829 INFO (qtp596302720-22921) [n:127.0.0.1:60494_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> 1616830 INFO (qtp596302720-22921) [n:127.0.0.1:60494_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_60494.solr.core.testScheduledTrigger.shard1.replica_n2'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n2') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@26755773
[junit4] 2> 1616830 INFO (qtp596302720-22921) [n:127.0.0.1:60494_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.SolrCore
[[testScheduledTrigger_shard1_replica_n2] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_7C1E5F7ED8AF67CD-001\tempDir-001\node1\.\testScheduledTrigger_shard1_replica_n2],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_7C1E5F7ED8AF67CD-001\tempDir-001\node1\.\testScheduledTrigger_shard1_replica_n2\data\]
[junit4] 2> 1616837 INFO (qtp596302720-22924) [n:127.0.0.1:60494_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> 1616837 INFO (qtp596302720-22924) [n:127.0.0.1:60494_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> 1616837 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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> 1616837 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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> 1616837 INFO (qtp596302720-22924) [n:127.0.0.1:60494_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_60494.solr.core.testScheduledTrigger.shard1.replica_n4'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n4') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@26755773
[junit4] 2> 1616837 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_60501.solr.core.testScheduledTrigger.shard1.replica_n1'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n1') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@26755773
[junit4] 2> 1616837 INFO (qtp596302720-22924) [n:127.0.0.1:60494_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.c.SolrCore
[[testScheduledTrigger_shard1_replica_n4] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_7C1E5F7ED8AF67CD-001\tempDir-001\node1\.\testScheduledTrigger_shard1_replica_n4],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_7C1E5F7ED8AF67CD-001\tempDir-001\node1\.\testScheduledTrigger_shard1_replica_n4\data\]
[junit4] 2> 1616837 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.SolrCore
[[testScheduledTrigger_shard1_replica_n1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_7C1E5F7ED8AF67CD-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_7C1E5F7ED8AF67CD-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n1\data\]
[junit4] 2> 1616950 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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> 1616950 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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> 1616950 INFO (qtp596302720-22921) [n:127.0.0.1:60494_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> 1616950 INFO (qtp596302720-22921) [n:127.0.0.1:60494_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> 1616953 INFO (qtp596302720-22924) [n:127.0.0.1:60494_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> 1616953 INFO (qtp596302720-22924) [n:127.0.0.1:60494_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> 1616953 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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> 1616953 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1616953 INFO (qtp596302720-22921) [n:127.0.0.1:60494_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> 1616953 INFO (qtp596302720-22921) [n:127.0.0.1:60494_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1616955 INFO (qtp596302720-22921) [n:127.0.0.1:60494_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> 1616955 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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> 1616956 INFO (qtp596302720-22924) [n:127.0.0.1:60494_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> 1616956 INFO (qtp596302720-22924) [n:127.0.0.1:60494_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1616956 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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> 1616956 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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> 1616956 INFO (qtp596302720-22921) [n:127.0.0.1:60494_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> 1616956 INFO (qtp596302720-22921) [n:127.0.0.1:60494_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> 1616957 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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> 1616957 INFO (qtp596302720-22921) [n:127.0.0.1:60494_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> 1616957 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1616957 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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> 1616957 INFO (qtp596302720-22921) [n:127.0.0.1:60494_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1616957 INFO (qtp596302720-22921) [n:127.0.0.1:60494_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> 1616957 INFO (qtp596302720-22924) [n:127.0.0.1:60494_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> 1616957 INFO (qtp596302720-22924) [n:127.0.0.1:60494_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> 1616957 INFO (qtp596302720-22924) [n:127.0.0.1:60494_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> 1616957 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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> 1616958 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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 1667383594262200320
[junit4] 2> 1616958 INFO (qtp596302720-22924) [n:127.0.0.1:60494_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> 1616958 INFO (qtp596302720-22921) [n:127.0.0.1:60494_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> 1616958 INFO (qtp596302720-22921) [n:127.0.0.1:60494_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 1667383594262200320
[junit4] 2> 1616958 INFO (qtp596302720-22924) [n:127.0.0.1:60494_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1616959 INFO (qtp596302720-22924) [n:127.0.0.1:60494_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> 1616960 INFO (qtp596302720-22924) [n:127.0.0.1:60494_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> 1616960 INFO
(searcherExecutor-14098-thread-1-processing-n:127.0.0.1:60501_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:60501_solr c:testScheduledTrigger s:shard1
r:core_node3 x:testScheduledTrigger_shard1_replica_n1 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1616960 INFO
(searcherExecutor-14098-thread-1-processing-n:127.0.0.1:60501_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:60501_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> 1616960 INFO (qtp596302720-22924) [n:127.0.0.1:60494_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 1667383594264297472
[junit4] 2> 1616960 INFO
(searcherExecutor-14094-thread-1-processing-n:127.0.0.1:60494_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:60494_solr c:testScheduledTrigger s:shard1
r:core_node5 x:testScheduledTrigger_shard1_replica_n2 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1616960 INFO
(searcherExecutor-14094-thread-1-processing-n:127.0.0.1:60494_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:60494_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> 1616961 INFO
(searcherExecutor-14094-thread-1-processing-n:127.0.0.1:60494_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:60494_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> 1616961 INFO
(searcherExecutor-14096-thread-1-processing-n:127.0.0.1:60494_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:60494_solr c:testScheduledTrigger s:shard1
r:core_node6 x:testScheduledTrigger_shard1_replica_n4 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1616961 INFO
(searcherExecutor-14096-thread-1-processing-n:127.0.0.1:60494_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:60494_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> 1616961 INFO
(searcherExecutor-14098-thread-1-processing-n:127.0.0.1:60501_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:60501_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> 1616962 INFO
(searcherExecutor-14096-thread-1-processing-n:127.0.0.1:60494_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:60494_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> 1616963 INFO (qtp596302720-22921) [n:127.0.0.1:60494_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.ZkShardTerms Failed to save
terms, version is not a match, retrying
[junit4] 2> 1616963 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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> 1616964 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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> 1616964 INFO (qtp596302720-22921) [n:127.0.0.1:60494_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> 1616964 INFO (qtp596302720-22921) [n:127.0.0.1:60494_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> 1616965 INFO (qtp596302720-22924) [n:127.0.0.1:60494_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> 1616965 INFO (qtp596302720-22924) [n:127.0.0.1:60494_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> 1616968 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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> 1616968 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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> 1616968 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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:60501/solr/testScheduledTrigger_shard1_replica_n1/
[junit4] 2> 1616969 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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:60501/solr
START
replicas=[http://127.0.0.1:60494/solr/testScheduledTrigger_shard1_replica_n2/,
http://127.0.0.1:60494/solr/testScheduledTrigger_shard1_replica_n4/]
nUpdates=100
[junit4] 2> 1616969 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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:60501/solr
DONE. We have no versions. sync failed.
[junit4] 2> 1616971 INFO (qtp596302720-22923) [n:127.0.0.1:60494_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> 1616971 INFO (qtp596302720-22993) [n:127.0.0.1:60494_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> 1616971 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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> 1616971 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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> 1616971 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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/72085263852109829-core_node3-n_0000000000
[junit4] 2> 1616973 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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:60501/solr/testScheduledTrigger_shard1_replica_n1/ shard1
[junit4] 2> 1616998 DEBUG (ScheduledTrigger-14061-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> 1617068 INFO (zkCallback-14055-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> 1617068 INFO (zkCallback-14055-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> 1617068 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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> 1617071 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_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=559
[junit4] 2> 1617162 INFO (zkCallback-14055-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> 1617162 INFO (zkCallback-14055-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> 1617162 INFO (zkCallback-14055-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> 1617890 INFO (qtp596302720-22921) [n:127.0.0.1:60494_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=1456
[junit4] 2> 1617890 INFO (qtp596302720-22924) [n:127.0.0.1:60494_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=1455
[junit4] 2> 1617890 DEBUG
(OverseerThreadFactory-14063-thread-1-processing-n:127.0.0.1:60501_solr)
[n:127.0.0.1:60501_solr ] o.a.s.c.s.c.a.PolicyHelper session set to NULL
[junit4] 2> 1617892 INFO (qtp596302720-22925) [n:127.0.0.1:60494_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> 1617915 DEBUG (ScheduledTrigger-14061-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> 1617980 INFO (zkCallback-14055-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> 1617980 INFO (zkCallback-14055-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> 1617980 INFO (zkCallback-14055-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> 1617980 INFO (zkCallback-14073-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> 1617980 INFO (zkCallback-14073-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> 1617980 INFO (qtp596302720-22925) [n:127.0.0.1:60494_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=1966
[junit4] 2> 1617980 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection:
testScheduledTrigger
[junit4] 2> 1617984 INFO (qtp596302720-22993) [n:127.0.0.1:60494_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> 1617986 INFO (qtp596302720-22923) [n:127.0.0.1:60494_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=1
[junit4] 2> 1617986 INFO (qtp1142173823-22929) [n:127.0.0.1:60501_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> 1617988 INFO (qtp1142173823-22928) [n:127.0.0.1:60501_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=1
[junit4] 2> 1617988 DEBUG (qtp1142173823-22927) [n:127.0.0.1:60501_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1617989 INFO (qtp1142173823-22927) [n:127.0.0.1:60501_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=7
[junit4] 2> 1617989 DEBUG (zkCallback-14055-thread-3) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
3
[junit4] 2> 1617990 DEBUG
(OverseerAutoScalingTriggerThread-72085263852109829-127.0.0.1:60501_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 3
[junit4] 2> 1617990 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding
port=0)
[junit4] 2> 1617990 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number
2 ...
[junit4] 2> 1617990 DEBUG
(OverseerAutoScalingTriggerThread-72085263852109829-127.0.0.1:60501_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1617990 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.e.j.s.Server jetty-9.4.27.v20200227; built:
2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm
12.0.2+10
[junit4] 2> 1617990 DEBUG
(OverseerAutoScalingTriggerThread-72085263852109829-127.0.0.1:60501_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3,
lastZnodeVersion 3
[junit4] 2> 1617990 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1617990 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1617990 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1617990 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@319cd0b2{/solr,null,AVAILABLE}
[junit4] 2> 1617990 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.e.j.s.AbstractConnector Started ServerConnector@496ae5e4{HTTP/1.1,
(http/1.1, h2c)}{127.0.0.1:60560}
[junit4] 2> 1617990 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.e.j.s.Server Started @1556418ms
[junit4] 2> 1617990 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=60560}
[junit4] 2> 1617990 ERROR
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging
may be missing or incomplete.
[junit4] 2> 1617990 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1617990 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™
version 9.0.0
[junit4] 2> 1617990 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on
port null
[junit4] 2> 1617990 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
[junit4] 2> 1617990 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-05-22T09:48:30.477211600Z
[junit4] 2> 1617990 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1617995 INFO (zkConnectionManagerCallback-14112-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1617995 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1617996 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1618017 INFO
(OverseerCollectionConfigSetProcessor-72085263852109829-127.0.0.1:60501_solr-n_0000000000)
[n:127.0.0.1:60501_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> 1618094 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1618096 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.e.j.u.s.S.config Trusting all certificates configured for
Client@350100c2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1618096 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm
configured for Client@350100c2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1618099 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.e.j.u.s.S.config Trusting all certificates configured for
Client@71c7015e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1618099 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm
configured for Client@71c7015e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1618100 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:60481/solr
[junit4] 2> 1618102 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[n:127.0.0.1:60560_solr ] o.a.s.c.c.ConnectionManager Waiting for client
to connect to ZooKeeper
[junit4] 2> 1618108 INFO (zkConnectionManagerCallback-14123-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1618108 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[n:127.0.0.1:60560_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1618118 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[n:127.0.0.1:60560_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 1618131 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[n:127.0.0.1:60560_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:60560_solr as DOWN
[junit4] 2> 1618131 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[n:127.0.0.1:60560_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 1000 transient cores
[junit4] 2> 1618131 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[n:127.0.0.1:60560_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:60560_solr
[junit4] 2> 1618131 INFO (zkCallback-14055-thread-3) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1618131 INFO (zkCallback-14091-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1618131 INFO (zkCallback-14073-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1618131 INFO (zkCallback-14122-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1618137 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[n:127.0.0.1:60560_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1618137 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[n:127.0.0.1:60560_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> 1618163 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[n:127.0.0.1:60560_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1618189 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[n:127.0.0.1:60560_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_60560.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@26755773
[junit4] 2> 1618198 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[n:127.0.0.1:60560_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_60560.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@26755773
[junit4] 2> 1618198 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[n:127.0.0.1:60560_solr ] o.a.s.m.r.SolrJmxReporter JMX mo
[...truncated too long message...]
rJmxReporter@b58517d: rootName = solr_60494, domain = solr.jetty, service url =
null, agent id = null] for registry
solr.jetty/com.codahale.metrics.MetricRegistry@6a99fe1a
[junit4] 2> 1662187 INFO (jetty-closer-14132-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster
tag=null
[junit4] 2> 1662275 INFO (jetty-closer-14132-thread-3) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@496ae5e4{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 1662275 INFO (jetty-closer-14132-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@319cd0b2{/solr,null,UNAVAILABLE}
[junit4] 2> 1662281 INFO (jetty-closer-14132-thread-3) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1662390 INFO (jetty-closer-14132-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72085263852109829-127.0.0.1:60501_solr-n_0000000000) closing
[junit4] 2> 1662393 INFO (jetty-closer-14132-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@4ad3c68d{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 1662393 INFO (jetty-closer-14132-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@5b4323ff{/solr,null,UNAVAILABLE}
[junit4] 2> 1662393 INFO (jetty-closer-14132-thread-1) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1662520 INFO (jetty-closer-14132-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@2d4d2181{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 1662520 INFO (jetty-closer-14132-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@19df298f{/solr,null,UNAVAILABLE}
[junit4] 2> 1662520 INFO (jetty-closer-14132-thread-2) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1662526 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 1662777 WARN (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 8
/solr/collections/testScheduledTrigger/terms/shard1
[junit4] 2> 4 /solr/aliases.json
[junit4] 2> 4 /solr/clusterprops.json
[junit4] 2> 3
/solr/configs/testScheduledTrigger.AUTOCREATED/managed-schema
[junit4] 2> 3 /solr/packages.json
[junit4] 2> 3 /solr/security.json
[junit4] 2> 2 /solr/configs/testScheduledTrigger.AUTOCREATED
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 26
/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> 4 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> 1662787 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:60481
[junit4] 2> 1662787 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:60481
[junit4] 2> 1662787 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 60481
[junit4] 2> 1665203 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[7C1E5F7ED8AF67CD])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testScheduledTrigger
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=ScheduledTriggerIntegrationTest -Dtests.method=testScheduledTrigger
-Dtests.seed=7C1E5F7ED8AF67CD -Dtests.slow=true -Dtests.locale=fo-DK
-Dtests.timezone=America/Argentina/Catamarca -Dtests.asserts=true
-Dtests.file.encoding=Cp1252
[junit4] FAILURE 49.5s J0 |
ScheduledTriggerIntegrationTest.testScheduledTrigger <<<
[junit4] > Throwable #1: java.lang.AssertionError: ScheduledTrigger did
not fire in time
[junit4] > at
__randomizedtesting.SeedInfo.seed([7C1E5F7ED8AF67CD:EF05170C86523CF9]: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:567)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:835)
[junit4] 2> NOTE: leaving temporary files on disk at:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_7C1E5F7ED8AF67CD-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene84): {},
docValues:{}, maxPointsInLeafNode=1982, maxMBSortInHeap=6.889010341678652,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@326afe30),
locale=fo-DK, timezone=America/Argentina/Catamarca
[junit4] 2> NOTE: Windows 10 10.0 amd64/AdoptOpenJDK 12.0.2
(64-bit)/cpus=6,threads=1,free=100445968,total=536870912
[junit4] 2> NOTE: All tests run in this JVM:
[OverriddenZkACLAndCredentialsProvidersTest, TestCustomSort, TestMissingGroups,
TestJsonFacets, EnumFieldTest, TestHttpShardHandlerFactory, MergeStrategyTest,
TestDynamicFieldResource, TestSolrCloudSnapshots,
ConcurrentDeleteAndCreateCollectionTest, NotRequiredUniqueKeyTest,
CreateCollectionCleanupTest, SystemLogListenerTest, TestHalfAndHalfDocValues,
ExitableDirectoryReaderTest, EmbeddedSolrNoSerializeTest,
XmlUpdateRequestHandlerTest, TestIndexSearcher, AnalysisAfterCoreReloadTest,
TestFieldCacheWithThreads, TestDistribIDF, SolrIndexConfigTest,
UUIDUpdateProcessorFallbackTest, UtilsToolTest,
FieldMutatingUpdateProcessorTest, HighlighterWithoutStoredIdTest,
TestPerFieldSimilarity, SimpleMLTQParserTest, TestSolrJacksonAnnotation,
TestRecoveryHdfs, TestJoin, TestFilteredDocIdSet, HealthCheckHandlerTest,
TestSolrConfigHandlerConcurrent, TestFieldCache,
TermVectorComponentDistributedTest, SignificantTermsQParserPluginTest,
MBeansHandlerTest, RequestHandlersTest, TestAnalyzeInfixSuggestions,
PreAnalyzedFieldTest, RoutingToNodesWithPropertiesTest,
TestNumericRangeQuery64, ParsingFieldUpdateProcessorsTest, SolrInfoBeanTest,
TestUnInvertedFieldException, UpdateParamsTest, JWTAuthPluginIntegrationTest,
DistributedSuggestComponentTest, TestRandomCollapseQParserPlugin,
TestTextField, TestJettySolrRunner, HdfsTlogReplayBufferedWhileIndexingTest,
DateFieldTest, TestExactStatsCacheCloud, DistributedFacetPivotLargeTest,
PhrasesIdentificationComponentTest, TestIBSimilarityFactory,
SpellCheckCollatorTest, LeaderElectionContextKeyTest,
IndexSizeTriggerSizeEstimationTest, MultiSolrCloudTestCaseTest,
TestStandardQParsers, TestBulkSchemaConcurrent, TestFacetMethods,
HdfsRecoverLeaseTest, FileUtilsTest, XmlInterpolationTest,
PKIAuthenticationIntegrationTest, TestReloadAndDeleteDocs,
TestCorePropertiesReload, FullHLLTest, TestReqParamsAPI, RulesTest,
TestDistribDocBasedVersion, TestTlogReplayVsRecovery,
TestLeaderElectionZkExpiry, ChaosMonkeyNothingIsSafeWithPullReplicasTest,
SmileWriterTest, TestSimExecutePlanAction,
PeerSyncWithLeaderAndIndexFingerprintCachingTest, TestMaxTokenLenTokenizer,
TestSha256AuthenticationProvider, UninvertDocValuesMergePolicyTest,
TestCaffeineCache, BadIndexSchemaTest, TestScoreJoinQPScore, AtomicUpdatesTest,
DeleteReplicaTest, UnloadDistributedZkTest, TestXmlQParser,
LeaderFailoverAfterPartitionTest, MissingSegmentRecoveryTest,
MoveReplicaHDFSFailoverTest, MoveReplicaHDFSTest, OverseerRolesTest,
OverseerTaskQueueTest, ReplaceNodeNoTargetTest, ReplaceNodeTest,
SplitShardTest, SystemCollectionCompatTest, TestAuthenticationFramework,
TestCloudDeleteByQuery, TestCloudRecovery, TestCloudSearcherWarming,
TestRandomFlRTGCloud, TestRandomRequestDistribution,
TestSizeLimitedDistributedMap, TestSolrCloudWithSecureImpersonation,
TestStressCloudBlindAtomicUpdates, TestWaitForStateWithJettyShutdowns,
AssignTest, AsyncCallRequestStatusResponseTest,
CollectionsAPIAsyncDistributedZkTest, TestCollectionAPI, ComputePlanActionTest,
NodeMarkersRegistrationTest, ScheduledTriggerIntegrationTest]
[junit4] Completed [627/913 (1!)] on J0 in 49.61s, 1 test, 1 failure <<<
FAILURES!
[...truncated 53393 lines...]
[repro] Jenkins log URL:
https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/8865/consoleText
[repro] Revision: 338671e511b753955f7186e7063cd95824cdf4e0
[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC"
[repro] JUnit rest result XML files will be moved to: ./repro-reports
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr\core
[repro] ScheduledTriggerIntegrationTest
[repro] ant compile-test
[...truncated 3156 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5
-Dtests.class="*.ScheduledTriggerIntegrationTest" -Dtests.showOutput=onerror
"-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC" -Dtests.seed=7C1E5F7ED8AF67CD
-Dtests.slow=true -Dtests.locale=fo-DK
-Dtests.timezone=America/Argentina/Catamarca -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: builds-unsubscr...@lucene.apache.org
For additional commands, e-mail: builds-h...@lucene.apache.org
