Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/8844/
Java: 64bit/jdk-14 -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([ECD08C460158A4A6:7FCBC4345FA5FF92]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.assertTrue(Assert.java:41)
at
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest.testScheduledTrigger(ScheduledTriggerIntegrationTest.java:120)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
at java.base/java.lang.Thread.run(Thread.java:832)
Build Log:
[...truncated 14875 lines...]
[junit4] Suite:
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest
[junit4] 2> 1620714 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[ECD08C460158A4A6]-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> 1620716 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[ECD08C460158A4A6]-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_ECD08C460158A4A6-001\data-dir-161-001
[junit4] 2> 1620716 WARN
(SUITE-ScheduledTriggerIntegrationTest-seed#[ECD08C460158A4A6]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 1620716 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[ECD08C460158A4A6]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1620725 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[ECD08C460158A4A6]-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> 1620725 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[ECD08C460158A4A6]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1620733 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testScheduledTrigger
[junit4] 2> 1620734 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] 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_ECD08C460158A4A6-001\tempDir-001
[junit4] 2> 1620735 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1620735 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 1620735 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1620859 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.ZkTestServer start zk server on port: 65105
[junit4] 2> 1620859 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:65105
[junit4] 2> 1620859 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:65105
[junit4] 2> 1620859 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 65105
[junit4] 2> 1620862 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1620869 INFO (zkConnectionManagerCallback-13158-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1620869 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1620873 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1620876 INFO (zkConnectionManagerCallback-13160-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1620876 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1620878 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1620880 INFO (zkConnectionManagerCallback-13162-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1620880 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1621014 INFO (jetty-launcher-13163-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1621014 INFO (jetty-launcher-13163-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1621014 INFO (jetty-launcher-13163-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1621014 INFO (jetty-launcher-13163-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1621014 INFO (jetty-launcher-13163-thread-1) [ ]
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git:
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 14+36
[junit4] 2> 1621014 INFO (jetty-launcher-13163-thread-2) [ ]
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git:
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 14+36
[junit4] 2> 1621015 INFO (jetty-launcher-13163-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1621015 INFO (jetty-launcher-13163-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1621016 INFO (jetty-launcher-13163-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1621016 INFO (jetty-launcher-13163-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1621016 INFO (jetty-launcher-13163-thread-2) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1621016 INFO (jetty-launcher-13163-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1621016 INFO (jetty-launcher-13163-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7993a967{/solr,null,AVAILABLE}
[junit4] 2> 1621016 INFO (jetty-launcher-13163-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@736c0b52{/solr,null,AVAILABLE}
[junit4] 2> 1621018 INFO (jetty-launcher-13163-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@5ec54d28{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:65119}
[junit4] 2> 1621018 INFO (jetty-launcher-13163-thread-2) [ ]
o.e.j.s.Server Started @1557989ms
[junit4] 2> 1621018 INFO (jetty-launcher-13163-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@5211c96b{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:65118}
[junit4] 2> 1621018 INFO (jetty-launcher-13163-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=65119}
[junit4] 2> 1621018 INFO (jetty-launcher-13163-thread-1) [ ]
o.e.j.s.Server Started @1557989ms
[junit4] 2> 1621018 INFO (jetty-launcher-13163-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=65118}
[junit4] 2> 1621018 ERROR (jetty-launcher-13163-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1621018 INFO (jetty-launcher-13163-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1621018 ERROR (jetty-launcher-13163-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1621018 INFO (jetty-launcher-13163-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1621018 INFO (jetty-launcher-13163-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
9.0.0
[junit4] 2> 1621018 INFO (jetty-launcher-13163-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
9.0.0
[junit4] 2> 1621018 INFO (jetty-launcher-13163-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1621018 INFO (jetty-launcher-13163-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1621018 INFO (jetty-launcher-13163-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
[junit4] 2> 1621018 INFO (jetty-launcher-13163-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
[junit4] 2> 1621018 INFO (jetty-launcher-13163-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-05-17T20:48:14.383998600Z
[junit4] 2> 1621018 INFO (jetty-launcher-13163-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-05-17T20:48:14.383998600Z
[junit4] 2> 1621019 INFO (jetty-launcher-13163-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1621020 INFO (jetty-launcher-13163-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1621022 INFO (zkConnectionManagerCallback-13166-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1621022 INFO (zkConnectionManagerCallback-13167-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1621022 INFO (jetty-launcher-13163-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1621022 INFO (jetty-launcher-13163-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1621023 INFO (jetty-launcher-13163-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1621023 INFO (jetty-launcher-13163-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1621155 INFO (jetty-launcher-13163-thread-2) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1621156 WARN (jetty-launcher-13163-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@5400283d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1621156 WARN (jetty-launcher-13163-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@5400283d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1621160 WARN (jetty-launcher-13163-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@2a97ac2e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1621160 WARN (jetty-launcher-13163-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@2a97ac2e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1621161 INFO (jetty-launcher-13163-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:65105/solr
[junit4] 2> 1621162 INFO (jetty-launcher-13163-thread-2)
[n:127.0.0.1:65119_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1621166 INFO (zkConnectionManagerCallback-13178-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1621166 INFO (jetty-launcher-13163-thread-2)
[n:127.0.0.1:65119_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1621256 INFO (jetty-launcher-13163-thread-2)
[n:127.0.0.1:65119_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:65119_solr
[junit4] 2> 1621257 INFO (jetty-launcher-13163-thread-2)
[n:127.0.0.1:65119_solr ] o.a.s.c.Overseer Overseer
(id=72060423277117445-127.0.0.1:65119_solr-n_0000000000) starting
[junit4] 2> 1621260 INFO (jetty-launcher-13163-thread-2)
[n:127.0.0.1:65119_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:65119_solr
[junit4] 2> 1621260 INFO
(OverseerStateUpdate-72060423277117445-127.0.0.1:65119_solr-n_0000000000)
[n:127.0.0.1:65119_solr ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:65119_solr
[junit4] 2> 1621260 DEBUG
(OverseerAutoScalingTriggerThread-72060423277117445-127.0.0.1:65119_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and
.scheduled_maintenance triggers
[junit4] 2> 1621260 INFO
(OverseerStateUpdate-72060423277117445-127.0.0.1:65119_solr-n_0000000000)
[n:127.0.0.1:65119_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1621260 DEBUG
(OverseerAutoScalingTriggerThread-72060423277117445-127.0.0.1:65119_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with
znode version 1
[junit4] 2> 1621260 DEBUG
(OverseerAutoScalingTriggerThread-72060423277117445-127.0.0.1:65119_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1,
lastZnodeVersion 0
[junit4] 2> 1621260 DEBUG
(OverseerAutoScalingTriggerThread-72060423277117445-127.0.0.1:65119_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 1
[junit4] 2> 1621265 INFO (jetty-launcher-13163-thread-2)
[n:127.0.0.1:65119_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1621265 WARN (jetty-launcher-13163-thread-2)
[n:127.0.0.1:65119_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> 1621265 DEBUG
(OverseerAutoScalingTriggerThread-72060423277117445-127.0.0.1:65119_solr-n_0000000000)
[ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial
livenodes: [127.0.0.1:65119_solr]
[junit4] 2> 1621265 DEBUG
(OverseerAutoScalingTriggerThread-72060423277117445-127.0.0.1:65119_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1621265 DEBUG (ScheduledTrigger-13183-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> 1621265 DEBUG
(OverseerAutoScalingTriggerThread-72060423277117445-127.0.0.1:65119_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1,
lastZnodeVersion 1
[junit4] 2> 1621274 INFO (jetty-launcher-13163-thread-1) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1621274 WARN (jetty-launcher-13163-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@6385e7d3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1621274 WARN (jetty-launcher-13163-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@6385e7d3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1621279 WARN (jetty-launcher-13163-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@222fabbd[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1621279 WARN (jetty-launcher-13163-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@222fabbd[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1621280 INFO (jetty-launcher-13163-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:65105/solr
[junit4] 2> 1621281 INFO (jetty-launcher-13163-thread-1)
[n:127.0.0.1:65118_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1621283 INFO (zkConnectionManagerCallback-13196-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1621283 INFO (jetty-launcher-13163-thread-1)
[n:127.0.0.1:65118_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1621288 INFO (jetty-launcher-13163-thread-1)
[n:127.0.0.1:65118_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1621289 INFO (jetty-launcher-13163-thread-2)
[n:127.0.0.1:65119_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1621291 INFO (jetty-launcher-13163-thread-1)
[n:127.0.0.1:65118_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:65118_solr as DOWN
[junit4] 2> 1621292 INFO (jetty-launcher-13163-thread-1)
[n:127.0.0.1:65118_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 1000 transient cores
[junit4] 2> 1621292 INFO (jetty-launcher-13163-thread-1)
[n:127.0.0.1:65118_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:65118_solr
[junit4] 2> 1621293 INFO (zkCallback-13177-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1621293 INFO (zkCallback-13195-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1621294 INFO (jetty-launcher-13163-thread-1)
[n:127.0.0.1:65118_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1621295 WARN (jetty-launcher-13163-thread-1)
[n:127.0.0.1:65118_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> 1621311 INFO (jetty-launcher-13163-thread-2)
[n:127.0.0.1:65119_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_65119.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@795589b5
[junit4] 2> 1621319 INFO (jetty-launcher-13163-thread-1)
[n:127.0.0.1:65118_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1621321 INFO (jetty-launcher-13163-thread-2)
[n:127.0.0.1:65119_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_65119.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@795589b5
[junit4] 2> 1621321 INFO (jetty-launcher-13163-thread-2)
[n:127.0.0.1:65119_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_65119.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@795589b5
[junit4] 2> 1621321 INFO (jetty-launcher-13163-thread-2)
[n:127.0.0.1:65119_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_ECD08C460158A4A6-001\tempDir-001\node2\.
[junit4] 2> 1621339 INFO (jetty-launcher-13163-thread-1)
[n:127.0.0.1:65118_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_65118.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@795589b5
[junit4] 2> 1621345 INFO (jetty-launcher-13163-thread-1)
[n:127.0.0.1:65118_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_65118.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@795589b5
[junit4] 2> 1621345 INFO (jetty-launcher-13163-thread-1)
[n:127.0.0.1:65118_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_65118.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@795589b5
[junit4] 2> 1621347 INFO (jetty-launcher-13163-thread-1)
[n:127.0.0.1:65118_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_ECD08C460158A4A6-001\tempDir-001\node1\.
[junit4] 2> 1621359 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
[junit4] 2> 1621361 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1621363 INFO (zkConnectionManagerCallback-13214-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1621363 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1621364 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1621365 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at
127.0.0.1:65105/solr ready
[junit4] 2> 1621371 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1621378 INFO (qtp1557544065-21104) [n:127.0.0.1:65118_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=3
[junit4] 2> 1621381 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=1
[junit4] 2> 1621382 DEBUG (qtp1342351704-21101) [n:127.0.0.1:65119_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1621382 INFO (qtp1342351704-21101) [n:127.0.0.1:65119_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=7
[junit4] 2> 1621382 DEBUG (zkCallback-13177-thread-1) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
2
[junit4] 2> 1621383 DEBUG
(OverseerAutoScalingTriggerThread-72060423277117445-127.0.0.1:65119_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 2
[junit4] 2> 1621384 INFO (qtp1342351704-21103) [n:127.0.0.1:65119_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> 1621384 DEBUG
(OverseerAutoScalingTriggerThread-72060423277117445-127.0.0.1:65119_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1621385 DEBUG
(OverseerAutoScalingTriggerThread-72060423277117445-127.0.0.1:65119_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2,
lastZnodeVersion 2
[junit4] 2> 1621387 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
testScheduledTrigger
[junit4] 2> 1621387 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/managed-schema to
/configs/testScheduledTrigger.AUTOCREATED/managed-schema
[junit4] 2> 1621389 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/protwords.txt to
/configs/testScheduledTrigger.AUTOCREATED/protwords.txt
[junit4] 2> 1621391 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621392 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621394 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621395 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621397 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621398 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621400 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621402 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621404 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621405 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621407 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621409 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621410 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621412 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621413 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621416 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621418 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621419 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621421 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621424 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621426 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621427 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621429 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621429 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621429 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621434 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621434 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621438 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621438 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621438 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621442 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621444 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621445 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621448 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621450 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621452 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621454 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621456 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621457 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621460 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/solrconfig.xml to
/configs/testScheduledTrigger.AUTOCREATED/solrconfig.xml
[junit4] 2> 1621461 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/synonyms.txt to
/configs/testScheduledTrigger.AUTOCREATED/synonyms.txt
[junit4] 2> 1621463 INFO
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/stopwords.txt to
/configs/testScheduledTrigger.AUTOCREATED/stopwords.txt
[junit4] 2> 1621588 WARN
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_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> 1621590 DEBUG
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_solr ] o.a.s.c.s.c.a.PolicyHelper Creating a new session
[junit4] 2> 1621591 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=2
[junit4] 2> 1621597 INFO (qtp1557544065-21106) [n:127.0.0.1:65118_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=2
[junit4] 2> 1621598 DEBUG
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_solr ] o.a.s.c.s.c.a.PolicyHelper New session created
[junit4] 2> 1621601 INFO (qtp1342351704-21101) [n:127.0.0.1:65119_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=2
[junit4] 2> 1621605 INFO (qtp1557544065-21100) [n:127.0.0.1:65118_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=3
[junit4] 2> 1621608 DEBUG
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_solr ] o.a.s.c.s.c.a.PolicyHelper returnSession,
curr-time 43171477 sessionWrapper.createTime 43171469002900,
this.sessionWrapper.createTime 43171469002900
[junit4] 2> 1621611 INFO
(OverseerStateUpdate-72060423277117445-127.0.0.1:65119_solr-n_0000000000)
[n:127.0.0.1:65119_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:65118/solr",
[junit4] 2> "node_name":"127.0.0.1:65118_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1621614 INFO
(OverseerStateUpdate-72060423277117445-127.0.0.1:65119_solr-n_0000000000)
[n:127.0.0.1:65119_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:65119/solr",
[junit4] 2> "node_name":"127.0.0.1:65119_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1621617 INFO
(OverseerStateUpdate-72060423277117445-127.0.0.1:65119_solr-n_0000000000)
[n:127.0.0.1:65119_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:65119/solr",
[junit4] 2> "node_name":"127.0.0.1:65119_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1621868 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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> 1621868 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_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> 1621868 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_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> 1621869 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_solr
x:testScheduledTrigger_shard1_replica_n4 ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 1000
transient cores
[junit4] 2> 1621897 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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> 1621898 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_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> 1621898 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_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> 1621922 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1621923 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1621929 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1622151 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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> 1622151 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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> 1622152 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_65118.solr.core.testScheduledTrigger.shard1.replica_n1'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n1') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@795589b5
[junit4] 2> 1622152 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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_ECD08C460158A4A6-001\tempDir-001\node1\.\testScheduledTrigger_shard1_replica_n1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_ECD08C460158A4A6-001\tempDir-001\node1\.\testScheduledTrigger_shard1_replica_n1\data\]
[junit4] 2> 1622162 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_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> 1622162 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_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> 1622162 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_65119.solr.core.testScheduledTrigger.shard1.replica_n4'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n4') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@795589b5
[junit4] 2> 1622162 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_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_ECD08C460158A4A6-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n4],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_ECD08C460158A4A6-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n4\data\]
[junit4] 2> 1622169 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_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> 1622169 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_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> 1622170 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_65119.solr.core.testScheduledTrigger.shard1.replica_n2'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n2') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@795589b5
[junit4] 2> 1622170 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_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_ECD08C460158A4A6-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n2],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_ECD08C460158A4A6-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n2\data\]
[junit4] 2> 1622283 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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> 1622283 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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> 1622287 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_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> 1622287 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_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> 1622288 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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> 1622288 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1622292 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_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> 1622292 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1622292 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_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> 1622292 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_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> 1622293 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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> 1622294 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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> 1622294 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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> 1622296 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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> 1622296 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_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> 1622296 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_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> 1622296 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1622297 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1622297 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_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> 1622297 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_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> 1622297 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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> 1622298 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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> 1622298 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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 1666972118588325888
[junit4] 2> 1622302 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_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> 1622302 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_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> 1622302 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1622302 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_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> 1622303 INFO
(searcherExecutor-13216-thread-1-processing-n:127.0.0.1:65118_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:65118_solr c:testScheduledTrigger s:shard1
r:core_node3 x:testScheduledTrigger_shard1_replica_n1 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1622303 INFO
(searcherExecutor-13216-thread-1-processing-n:127.0.0.1:65118_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:65118_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> 1622303 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_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> 1622303 INFO
(searcherExecutor-13216-thread-1-processing-n:127.0.0.1:65118_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:65118_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> 1622303 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_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 1666972118593568768
[junit4] 2> 1622304 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_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> 1622304 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_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> 1622307 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_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> 1622307 INFO
(searcherExecutor-13220-thread-1-processing-n:127.0.0.1:65119_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:65119_solr c:testScheduledTrigger s:shard1
r:core_node5 x:testScheduledTrigger_shard1_replica_n2 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1622307 INFO
(searcherExecutor-13220-thread-1-processing-n:127.0.0.1:65119_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:65119_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> 1622308 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1622308 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_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> 1622308 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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> 1622308 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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> 1622308 INFO
(searcherExecutor-13220-thread-1-processing-n:127.0.0.1:65119_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:65119_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> 1622309 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_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> 1622309 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_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 1666972118599860224
[junit4] 2> 1622312 INFO
(searcherExecutor-13218-thread-1-processing-n:127.0.0.1:65119_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:65119_solr c:testScheduledTrigger s:shard1
r:core_node6 x:testScheduledTrigger_shard1_replica_n4 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1622312 INFO
(searcherExecutor-13218-thread-1-processing-n:127.0.0.1:65119_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:65119_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> 1622314 INFO
(searcherExecutor-13218-thread-1-processing-n:127.0.0.1:65119_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:65119_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> 1622315 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_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> 1622315 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_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> 1622315 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_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> 1622315 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_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> 1622320 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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> 1622320 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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> 1622320 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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:65118/solr/testScheduledTrigger_shard1_replica_n1/
[junit4] 2> 1622320 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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:65118/solr
START
replicas=[http://127.0.0.1:65119/solr/testScheduledTrigger_shard1_replica_n2/,
http://127.0.0.1:65119/solr/testScheduledTrigger_shard1_replica_n4/]
nUpdates=100
[junit4] 2> 1622321 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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:65118/solr
DONE. We have no versions. sync failed.
[junit4] 2> 1622323 INFO (qtp1342351704-21169) [n:127.0.0.1:65119_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> 1622323 INFO (qtp1342351704-21101) [n:127.0.0.1:65119_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> 1622324 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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> 1622324 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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> 1622324 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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/72060423277117446-core_node3-n_0000000000
[junit4] 2> 1622326 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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:65118/solr/testScheduledTrigger_shard1_replica_n1/ shard1
[junit4] 2> 1622456 INFO (zkCallback-13195-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testScheduledTrigger/state.json] for collection
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1622456 INFO (zkCallback-13195-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testScheduledTrigger/state.json] for collection
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1622459 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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> 1622464 INFO (qtp1557544065-21102) [n:127.0.0.1:65118_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=490
[junit4] 2> 1622484 DEBUG (ScheduledTrigger-13183-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> 1622585 INFO (zkCallback-13195-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testScheduledTrigger/state.json] for collection
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1622585 INFO (zkCallback-13195-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testScheduledTrigger/state.json] for collection
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1622586 INFO (zkCallback-13195-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testScheduledTrigger/state.json] for collection
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1623545 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_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=1379
[junit4] 2> 1623545 INFO (qtp1342351704-21099) [n:127.0.0.1:65119_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=1379
[junit4] 2> 1623545 DEBUG
(OverseerThreadFactory-13185-thread-1-processing-n:127.0.0.1:65119_solr)
[n:127.0.0.1:65119_solr ] o.a.s.c.s.c.a.PolicyHelper session set to NULL
[junit4] 2> 1623547 INFO (qtp1342351704-21103) [n:127.0.0.1:65119_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> 1623665 INFO (zkCallback-13177-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> 1623665 INFO (zkCallback-13177-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> 1623665 INFO (zkCallback-13195-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testScheduledTrigger/state.json] for collection
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1623665 INFO (zkCallback-13195-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testScheduledTrigger/state.json] for collection
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1623665 INFO (zkCallback-13195-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/testScheduledTrigger/state.json] for collection
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1623666 INFO (qtp1342351704-21103) [n:127.0.0.1:65119_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={pullReplicas=0&maxShardsPerNode=5&name=testScheduledTrigger&nrtReplicas=3&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2}
status=0 QTime=1878
[junit4] 2> 1623666 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection:
testScheduledTrigger
[junit4] 2> 1623677 INFO (qtp1342351704-21101) [n:127.0.0.1:65119_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> 1623681 INFO (qtp1342351704-21105) [n:127.0.0.1:65119_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=2
[junit4] 2> 1623682 INFO (qtp1557544065-21104) [n:127.0.0.1:65118_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> 1623684 INFO (qtp1557544065-21106) [n:127.0.0.1:65118_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=1
[junit4] 2> 1623684 DEBUG (qtp1342351704-21169) [n:127.0.0.1:65119_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1623686 INFO (qtp1342351704-21169) [n:127.0.0.1:65119_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=10
[junit4] 2> 1623686 DEBUG (zkCallback-13177-thread-3) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
3
[junit4] 2> 1623687 DEBUG
(OverseerAutoScalingTriggerThread-72060423277117445-127.0.0.1:65119_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 3
[junit4] 2> 1623687 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding
port=0)
[junit4] 2> 1623687 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number
2 ...
[junit4] 2> 1623687 DEBUG
(OverseerAutoScalingTriggerThread-72060423277117445-127.0.0.1:65119_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1623687 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.e.j.s.Server jetty-9.4.27.v20200227; built:
2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm
14+36
[junit4] 2> 1623688 DEBUG
(OverseerAutoScalingTriggerThread-72060423277117445-127.0.0.1:65119_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3,
lastZnodeVersion 3
[junit4] 2> 1623688 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1623688 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1623688 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1623688 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@53ea39b{/solr,null,AVAILABLE}
[junit4] 2> 1623691 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.e.j.s.AbstractConnector Started ServerConnector@647ddd35{HTTP/1.1,
(http/1.1, h2c)}{127.0.0.1:65179}
[junit4] 2> 1623691 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.e.j.s.Server Started @1560189ms
[junit4] 2> 1623691 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=65179}
[junit4] 2> 1623692 ERROR
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging
may be missing or incomplete.
[junit4] 2> 1623692 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1623692 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™
version 9.0.0
[junit4] 2> 1623692 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on
port null
[junit4] 2> 1623692 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
[junit4] 2> 1623692 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-05-17T20:48:17.057015700Z
[junit4] 2> 1623693 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1623696 INFO (zkConnectionManagerCallback-13234-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1623696 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1623696 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1623706 DEBUG (ScheduledTrigger-13183-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> 1623815 INFO
(OverseerCollectionConfigSetProcessor-72060423277117445-127.0.0.1:65119_solr-n_0000000000)
[n:127.0.0.1:65119_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> 1623832 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1623834 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.e.j.u.s.S.config Trusting all certificates configured for
Client@63ac7d5f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1623834 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm
configured for Client@63ac7d5f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1623837 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.e.j.u.s.S.config Trusting all certificates configured for
Client@6925b13b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1623837 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm
configured for Client@6925b13b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1623838 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:65105/solr
[junit4] 2> 1623840 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[n:127.0.0.1:65179_solr ] o.a.s.c.c.ConnectionManager Waiting for client
to connect to ZooKeeper
[junit4] 2> 1623845 INFO (zkConnectionManagerCallback-13245-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1623845 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[n:127.0.0.1:65179_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1623852 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[n:127.0.0.1:65179_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 1623856 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[n:127.0.0.1:65179_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:65179_solr as DOWN
[junit4] 2> 1623857 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[n:127.0.0.1:65179_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 1000 transient cores
[junit4] 2> 1623858 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[n:127.0.0.1:65179_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:65179_solr
[junit4] 2> 1623868 INFO (zkCallback-13177-thread-3) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1623868 INFO (zkCallback-13213-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1623868 INFO (zkCallback-13195-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1623868 INFO (zkCallback-13244-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1623869 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[n:127.0.0.1:65179_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1623870 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[n:127.0.0.1:65179_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> 1623901 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[n:127.0.0.1:65179_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1623931 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[n:127.0.0.1:65179_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_65179.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@795589b5
[junit4] 2> 1623946 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[n:127.0.0.1:65179_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_65179.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@795589b5
[junit4] 2> 1623946 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD0
[...truncated too long message...]
INFO (closeThreadPool-13271-thread-2) [ ] o.a.s.c.Overseer Overseer
(id=72060423277117445-127.0.0.1:65119_solr-n_0000000000) closing
[junit4] 2> 1665263 INFO (jetty-closer-13254-thread-3) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@647ddd35{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 1665263 INFO (jetty-closer-13254-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@53ea39b{/solr,null,UNAVAILABLE}
[junit4] 2> 1665263 INFO (jetty-closer-13254-thread-3) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1665270 INFO (zkCallback-13177-thread-3) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 1665270 INFO (jetty-closer-13254-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@5211c96b{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 1665270 INFO (jetty-closer-13254-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@7993a967{/solr,null,UNAVAILABLE}
[junit4] 2> 1665270 INFO (jetty-closer-13254-thread-2) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1665345 INFO (jetty-closer-13254-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72060423277117445-127.0.0.1:65119_solr-n_0000000000) closing
[junit4] 2> 1665346 INFO (jetty-closer-13254-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@5ec54d28{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 1665346 INFO (jetty-closer-13254-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@736c0b52{/solr,null,UNAVAILABLE}
[junit4] 2> 1665346 INFO (jetty-closer-13254-thread-1) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1665346 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 1665494 WARN (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 7
/solr/collections/testScheduledTrigger/terms/shard1
[junit4] 2> 4 /solr/aliases.json
[junit4] 2> 4 /solr/clusterprops.json
[junit4] 2> 3
/solr/configs/testScheduledTrigger.AUTOCREATED/managed-schema
[junit4] 2> 3 /solr/packages.json
[junit4] 2> 3 /solr/security.json
[junit4] 2> 2 /solr/configs/testScheduledTrigger.AUTOCREATED
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 25
/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> 1665497 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:65105
[junit4] 2> 1665497 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:65105
[junit4] 2> 1665497 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 65105
[junit4] 2> 1666933 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[ECD08C460158A4A6])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testScheduledTrigger
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=ScheduledTriggerIntegrationTest -Dtests.method=testScheduledTrigger
-Dtests.seed=ECD08C460158A4A6 -Dtests.slow=true -Dtests.locale=ko-KP
-Dtests.timezone=America/Punta_Arenas -Dtests.asserts=true
-Dtests.file.encoding=Cp1252
[junit4] FAILURE 46.2s J0 |
ScheduledTriggerIntegrationTest.testScheduledTrigger <<<
[junit4] > Throwable #1: java.lang.AssertionError: ScheduledTrigger did
not fire in time
[junit4] > at
__randomizedtesting.SeedInfo.seed([ECD08C460158A4A6:7FCBC4345FA5FF92]:0)
[junit4] > at
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest.testScheduledTrigger(ScheduledTriggerIntegrationTest.java:120)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] > at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at
java.base/java.lang.reflect.Method.invoke(Method.java:564)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:832)
[junit4] 2> NOTE: leaving temporary files on disk at:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_ECD08C460158A4A6-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene84): {},
docValues:{}, maxPointsInLeafNode=1596, maxMBSortInHeap=5.692439501115976,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@688250c),
locale=ko-KP, timezone=America/Punta_Arenas
[junit4] 2> NOTE: Windows 10 10.0 amd64/AdoptOpenJDK 14
(64-bit)/cpus=6,threads=1,free=84063544,total=450887680
[junit4] 2> NOTE: All tests run in this JVM:
[PhrasesIdentificationComponentTest, TestTextField, TestJsonFacetsStatsParsing,
EmbeddedSolrNoSerializeTest, TestReplicaProperties,
HdfsBasicDistributedZk2Test, NotRequiredUniqueKeyTest, SolrInfoBeanTest,
CoreAdminHandlerTest, TestLegacyFieldReuse, BadIndexSchemaTest,
SolrLogAuditLoggerPluginTest, TestRawTransformer, ZookeeperReadAPITest,
TestSnapshotCloudManager, DOMUtilTest, DateFieldTest, TestObjectReleaseTracker,
TestCoreBackup, ConjunctionSolrSpellCheckerTest, TestLegacyFieldCache,
TestSchemaNameResource, TestFieldCacheReopen, TestHalfAndHalfDocValues,
TestExactSharedStatsCache, PeerSyncReplicationTest,
TestDelegationWithHadoopAuth, TestNestedUpdateProcessor,
DistributedFacetPivotLargeTest, TestCaffeineCache, PeerSyncWithLeaderTest,
SplitByPrefixTest, HdfsTlogReplayBufferedWhileIndexingTest,
TestCloudPseudoReturnFields, TestSegmentSorting,
SignificantTermsQParserPluginTest, TestBulkSchemaConcurrent,
UnloadDistributedZkTest, TestStressVersions, TestDistributedMissingSort,
TestRandomCollapseQParserPlugin, MultiSolrCloudTestCaseTest,
IgnoreCommitOptimizeUpdateProcessorFactoryTest, DistribJoinFromCollectionTest,
TokenizerChainTest, LeaderTragicEventTest, TestSystemIdResolver,
TestCharFilters, TriggerSetPropertiesIntegrationTest, TestReloadAndDeleteDocs,
PreAnalyzedFieldTest, NodeAddedTriggerTest, TestBM25SimilarityFactory,
TestInPlaceUpdateWithRouteField, TestTlogReplayVsRecovery,
SolrJmxReporterCloudTest, BasicAuthIntegrationTest, ShardsWhitelistTest,
TestConfigSetImmutable, AnalysisAfterCoreReloadTest,
TestSolrCloudWithKerberosAlt, TestConfigSetsAPI,
DocumentAnalysisRequestHandlerTest, CustomTermsComponentTest,
SystemInfoHandlerTest, TestSimExecutePlanAction, TestMinMaxOnMultiValuedField,
TestCloudConsistency, ReplaceNodeNoTargetTest, TestSolrConfigHandlerConcurrent,
TestPartialUpdateDeduplication, CloudExitableDirectoryReaderTest,
TestPayloadScoreQParserPlugin, ExitableDirectoryReaderTest,
SolrCoreMetricManagerTest, TestHighFrequencyDictionaryFactory,
TestCloudJSONFacetJoinDomain, ForceLeaderWithTlogReplicasTest,
TestSolrCoreParser, TestDistribDocBasedVersion, XmlInterpolationTest,
CollectionStateFormat2Test, TestAnalyzedSuggestions,
DefaultValueUpdateProcessorTest, TestHttpShardHandlerFactory,
CdcrReplicationHandlerTest, RulesTest, IndexSizeTriggerSizeEstimationTest,
TestJoin, ComputePlanActionTest, DistributedIntervalFacetingTest,
TestDocumentBuilder, TestGroupingSearch, TestHighlightDedupGrouping,
TestSolrTestCaseJ4, TestTolerantSearch, TestTrie,
PathHierarchyTokenizerFactoryTest, TestJettySolrRunner, ActionThrottleTest,
AddReplicaTest, ChaosMonkeyNothingIsSafeWithPullReplicasTest,
DistributedVersionInfoTest, LeaderElectionIntegrationTest,
NestedShardedAtomicUpdateTest, RoutingToNodesWithPropertiesTest,
SplitShardTest, TestCloudRecovery2, TestClusterProperties,
TestDynamicFieldNamesIndexCorrectly, TestLeaderElectionWithEmptyReplica,
TestRandomRequestDistribution, TestUtilizeNode, ZkFailoverTest,
AsyncCallRequestStatusResponseTest, CollectionTooManyReplicasTest,
TestCollectionsAPIViaSolrCloudCluster, MetricTriggerTest,
ScheduledTriggerIntegrationTest]
[junit4] Completed [589/912 (1!)] on J0 in 46.25s, 1 test, 1 failure <<<
FAILURES!
[...truncated 46033 lines...]
[repro] Jenkins log URL:
https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/8844/consoleText
[repro] Revision: 06df50e759a8edf2315dc421a5b12570577471a3
[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=ECD08C460158A4A6
-Dtests.slow=true -Dtests.locale=ko-KP -Dtests.timezone=America/Punta_Arenas
-Dtests.asserts=true -Dtests.file.encoding=Cp1252
[...truncated 82 lines...]
[repro] Failures w/original seeds:
[repro] 0/5 failed:
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest
[repro] Exiting with code 0
[...truncated 78 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]