Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/8868/
Java: 64bit/jdk-13.0.2 -XX:+UseCompressedOops -XX:+UseParallelGC
1 tests failed.
FAILED:
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest.testScheduledTrigger
Error Message:
ScheduledTrigger did not fire in time
Stack Trace:
java.lang.AssertionError: ScheduledTrigger did not fire in time
at
__randomizedtesting.SeedInfo.seed([884D92427B6B08BA:1B56DA302596538E]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.assertTrue(Assert.java:41)
at
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest.testScheduledTrigger(ScheduledTriggerIntegrationTest.java:120)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:567)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
at java.base/java.lang.Thread.run(Thread.java:830)
Build Log:
[...truncated 15088 lines...]
[junit4] Suite:
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest
[junit4] 2> 1439397 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[884D92427B6B08BA]-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> 1439398 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[884D92427B6B08BA]-worker) [ ]
o.a.s.SolrTestCaseJ4 Created dataDir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_884D92427B6B08BA-001\data-dir-102-001
[junit4] 2> 1439400 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[884D92427B6B08BA]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1439402 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[884D92427B6B08BA]-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> 1439402 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[884D92427B6B08BA]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1439405 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testScheduledTrigger
[junit4] 2> 1439407 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_884D92427B6B08BA-001\tempDir-001
[junit4] 2> 1439407 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1439407 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 1439408 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1439544 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.ZkTestServer start zk server on port: 49410
[junit4] 2> 1439544 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:49410
[junit4] 2> 1439544 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:49410
[junit4] 2> 1439544 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 49410
[junit4] 2> 1439548 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1439554 INFO (zkConnectionManagerCallback-14711-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1439554 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1439558 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1439561 INFO (zkConnectionManagerCallback-14713-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1439561 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1439562 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1439565 INFO (zkConnectionManagerCallback-14715-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1439565 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1439705 INFO (jetty-launcher-14716-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1439705 INFO (jetty-launcher-14716-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1439705 INFO (jetty-launcher-14716-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1439705 INFO (jetty-launcher-14716-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1439706 INFO (jetty-launcher-14716-thread-2) [ ]
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git:
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 13.0.2+8
[junit4] 2> 1439706 INFO (jetty-launcher-14716-thread-1) [ ]
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git:
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 13.0.2+8
[junit4] 2> 1439707 INFO (jetty-launcher-14716-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1439707 INFO (jetty-launcher-14716-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1439707 INFO (jetty-launcher-14716-thread-2) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1439707 INFO (jetty-launcher-14716-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1439707 INFO (jetty-launcher-14716-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1439707 INFO (jetty-launcher-14716-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1439707 INFO (jetty-launcher-14716-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6ebaef62{/solr,null,AVAILABLE}
[junit4] 2> 1439707 INFO (jetty-launcher-14716-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@79b9ca91{/solr,null,AVAILABLE}
[junit4] 2> 1439710 INFO (jetty-launcher-14716-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@79f7a085{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:49424}
[junit4] 2> 1439710 INFO (jetty-launcher-14716-thread-1) [ ]
o.e.j.s.Server Started @1386102ms
[junit4] 2> 1439710 INFO (jetty-launcher-14716-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=49424}
[junit4] 2> 1439710 ERROR (jetty-launcher-14716-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1439710 INFO (jetty-launcher-14716-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1439710 INFO (jetty-launcher-14716-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@424ba233{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:49423}
[junit4] 2> 1439710 INFO (jetty-launcher-14716-thread-2) [ ]
o.e.j.s.Server Started @1386103ms
[junit4] 2> 1439710 INFO (jetty-launcher-14716-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=49423}
[junit4] 2> 1439710 INFO (jetty-launcher-14716-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
9.0.0
[junit4] 2> 1439710 INFO (jetty-launcher-14716-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1439710 INFO (jetty-launcher-14716-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
[junit4] 2> 1439710 INFO (jetty-launcher-14716-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-05-23T01:45:23.896135300Z
[junit4] 2> 1439710 ERROR (jetty-launcher-14716-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1439710 INFO (jetty-launcher-14716-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1439710 INFO (jetty-launcher-14716-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
9.0.0
[junit4] 2> 1439710 INFO (jetty-launcher-14716-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1439710 INFO (jetty-launcher-14716-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
[junit4] 2> 1439710 INFO (jetty-launcher-14716-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-05-23T01:45:23.896135300Z
[junit4] 2> 1439711 INFO (jetty-launcher-14716-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1439711 INFO (jetty-launcher-14716-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1439713 INFO (zkConnectionManagerCallback-14718-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1439713 INFO (jetty-launcher-14716-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1439713 INFO (zkConnectionManagerCallback-14720-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1439713 INFO (jetty-launcher-14716-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1439714 INFO (jetty-launcher-14716-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1439714 INFO (jetty-launcher-14716-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1439859 INFO (jetty-launcher-14716-thread-2) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1439862 WARN (jetty-launcher-14716-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@4b1a5541[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1439862 WARN (jetty-launcher-14716-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@4b1a5541[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1439865 WARN (jetty-launcher-14716-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@593ad152[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1439865 WARN (jetty-launcher-14716-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@593ad152[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1439867 INFO (jetty-launcher-14716-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:49410/solr
[junit4] 2> 1439868 INFO (jetty-launcher-14716-thread-2)
[n:127.0.0.1:49423_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1439872 INFO (zkConnectionManagerCallback-14731-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1439872 INFO (jetty-launcher-14716-thread-2)
[n:127.0.0.1:49423_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1439995 INFO (jetty-launcher-14716-thread-1) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1439997 WARN (jetty-launcher-14716-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@4fdc96dd[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1439997 WARN (jetty-launcher-14716-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@4fdc96dd[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1439999 INFO (jetty-launcher-14716-thread-2)
[n:127.0.0.1:49423_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:49423_solr
[junit4] 2> 1440000 INFO (jetty-launcher-14716-thread-2)
[n:127.0.0.1:49423_solr ] o.a.s.c.Overseer Overseer
(id=72088897977974789-127.0.0.1:49423_solr-n_0000000000) starting
[junit4] 2> 1440003 WARN (jetty-launcher-14716-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@1befc5af[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1440003 WARN (jetty-launcher-14716-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@1befc5af[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1440003 INFO (jetty-launcher-14716-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:49410/solr
[junit4] 2> 1440005 INFO (jetty-launcher-14716-thread-1)
[n:127.0.0.1:49424_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1440007 INFO (zkConnectionManagerCallback-14744-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1440007 INFO (jetty-launcher-14716-thread-1)
[n:127.0.0.1:49424_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1440007 INFO
(OverseerStateUpdate-72088897977974789-127.0.0.1:49423_solr-n_0000000000)
[n:127.0.0.1:49423_solr ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:49423_solr
[junit4] 2> 1440007 INFO (jetty-launcher-14716-thread-2)
[n:127.0.0.1:49423_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:49423_solr
[junit4] 2> 1440007 DEBUG
(OverseerAutoScalingTriggerThread-72088897977974789-127.0.0.1:49423_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and
.scheduled_maintenance triggers
[junit4] 2> 1440009 INFO
(OverseerStateUpdate-72088897977974789-127.0.0.1:49423_solr-n_0000000000)
[n:127.0.0.1:49423_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1440009 DEBUG
(OverseerAutoScalingTriggerThread-72088897977974789-127.0.0.1:49423_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with
znode version 1
[junit4] 2> 1440009 DEBUG
(OverseerAutoScalingTriggerThread-72088897977974789-127.0.0.1:49423_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1,
lastZnodeVersion 0
[junit4] 2> 1440009 DEBUG
(OverseerAutoScalingTriggerThread-72088897977974789-127.0.0.1:49423_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 1
[junit4] 2> 1440011 INFO (jetty-launcher-14716-thread-2)
[n:127.0.0.1:49423_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1440012 WARN (jetty-launcher-14716-thread-2)
[n:127.0.0.1:49423_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> 1440014 DEBUG
(OverseerAutoScalingTriggerThread-72088897977974789-127.0.0.1:49423_solr-n_0000000000)
[ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial
livenodes: [127.0.0.1:49423_solr]
[junit4] 2> 1440014 DEBUG
(OverseerAutoScalingTriggerThread-72088897977974789-127.0.0.1:49423_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1440015 DEBUG (ScheduledTrigger-14747-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> 1440015 DEBUG
(OverseerAutoScalingTriggerThread-72088897977974789-127.0.0.1:49423_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1,
lastZnodeVersion 1
[junit4] 2> 1440025 INFO (jetty-launcher-14716-thread-1)
[n:127.0.0.1:49424_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1440030 INFO (jetty-launcher-14716-thread-1)
[n:127.0.0.1:49424_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:49424_solr as DOWN
[junit4] 2> 1440033 INFO (jetty-launcher-14716-thread-1)
[n:127.0.0.1:49424_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 1000 transient cores
[junit4] 2> 1440033 INFO (jetty-launcher-14716-thread-1)
[n:127.0.0.1:49424_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:49424_solr
[junit4] 2> 1440034 INFO (zkCallback-14730-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1440034 INFO (zkCallback-14743-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1440037 INFO (jetty-launcher-14716-thread-1)
[n:127.0.0.1:49424_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1440038 WARN (jetty-launcher-14716-thread-1)
[n:127.0.0.1:49424_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> 1440052 INFO (jetty-launcher-14716-thread-2)
[n:127.0.0.1:49423_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1440077 INFO (jetty-launcher-14716-thread-1)
[n:127.0.0.1:49424_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1440080 INFO (jetty-launcher-14716-thread-2)
[n:127.0.0.1:49423_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49423.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@17671c4f
[junit4] 2> 1440086 INFO (jetty-launcher-14716-thread-2)
[n:127.0.0.1:49423_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49423.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@17671c4f
[junit4] 2> 1440087 INFO (jetty-launcher-14716-thread-2)
[n:127.0.0.1:49423_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49423.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@17671c4f
[junit4] 2> 1440088 INFO (jetty-launcher-14716-thread-2)
[n:127.0.0.1:49423_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_884D92427B6B08BA-001\tempDir-001\node2\.
[junit4] 2> 1440103 INFO (jetty-launcher-14716-thread-1)
[n:127.0.0.1:49424_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49424.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@17671c4f
[junit4] 2> 1440111 INFO (jetty-launcher-14716-thread-1)
[n:127.0.0.1:49424_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49424.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@17671c4f
[junit4] 2> 1440111 INFO (jetty-launcher-14716-thread-1)
[n:127.0.0.1:49424_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49424.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@17671c4f
[junit4] 2> 1440114 INFO (jetty-launcher-14716-thread-1)
[n:127.0.0.1:49424_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_884D92427B6B08BA-001\tempDir-001\node1\.
[junit4] 2> 1440129 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
[junit4] 2> 1440129 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1440131 INFO (zkConnectionManagerCallback-14767-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1440131 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1440134 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1440134 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at
127.0.0.1:49410/solr ready
[junit4] 2> 1440143 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1440148 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 1000
transient cores
[junit4] 2> 1440150 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=2
[junit4] 2> 1440156 INFO (qtp1999654931-23221) [n:127.0.0.1:49424_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=3
[junit4] 2> 1440156 DEBUG (qtp1284261330-23220) [n:127.0.0.1:49423_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1440156 INFO (qtp1284261330-23220) [n:127.0.0.1:49423_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=9
[junit4] 2> 1440156 DEBUG (zkCallback-14730-thread-1) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
2
[junit4] 2> 1440160 DEBUG
(OverseerAutoScalingTriggerThread-72088897977974789-127.0.0.1:49423_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 2
[junit4] 2> 1440160 INFO (qtp1284261330-23222) [n:127.0.0.1:49423_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> 1440160 DEBUG
(OverseerAutoScalingTriggerThread-72088897977974789-127.0.0.1:49423_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1440164 DEBUG
(OverseerAutoScalingTriggerThread-72088897977974789-127.0.0.1:49423_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2,
lastZnodeVersion 2
[junit4] 2> 1440164 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
testScheduledTrigger
[junit4] 2> 1440165 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/managed-schema to
/configs/testScheduledTrigger.AUTOCREATED/managed-schema
[junit4] 2> 1440170 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/protwords.txt to
/configs/testScheduledTrigger.AUTOCREATED/protwords.txt
[junit4] 2> 1440170 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440170 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440170 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440170 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440180 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440182 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440185 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440185 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440191 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440191 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440196 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440198 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440201 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440201 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440204 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440207 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440209 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440213 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440215 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440218 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440218 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440222 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440222 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440227 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440227 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440231 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440231 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440231 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440238 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440238 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440242 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440242 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440245 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440248 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440248 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440248 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440253 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440253 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440259 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440259 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/solrconfig.xml to
/configs/testScheduledTrigger.AUTOCREATED/solrconfig.xml
[junit4] 2> 1440263 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/synonyms.txt to
/configs/testScheduledTrigger.AUTOCREATED/synonyms.txt
[junit4] 2> 1440265 INFO
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/stopwords.txt to
/configs/testScheduledTrigger.AUTOCREATED/stopwords.txt
[junit4] 2> 1440404 WARN
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_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> 1440404 DEBUG
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_solr ] o.a.s.c.s.c.a.PolicyHelper Creating a new session
[junit4] 2> 1440409 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=2
[junit4] 2> 1440415 INFO (qtp1999654931-23223) [n:127.0.0.1:49424_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=2
[junit4] 2> 1440415 DEBUG
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_solr ] o.a.s.c.s.c.a.PolicyHelper New session created
[junit4] 2> 1440420 INFO (qtp1284261330-23220) [n:127.0.0.1:49423_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=2
[junit4] 2> 1440422 INFO (qtp1999654931-23224) [n:127.0.0.1:49424_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=2
[junit4] 2> 1440425 DEBUG
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_solr ] o.a.s.c.s.c.a.PolicyHelper returnSession,
curr-time 477660967 sessionWrapper.createTime 477660958879300,
this.sessionWrapper.createTime 477660958879300
[junit4] 2> 1440430 INFO
(OverseerStateUpdate-72088897977974789-127.0.0.1:49423_solr-n_0000000000)
[n:127.0.0.1:49423_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:49424/solr";,
[junit4] 2> "node_name":"127.0.0.1:49424_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1440435 INFO
(OverseerStateUpdate-72088897977974789-127.0.0.1:49423_solr-n_0000000000)
[n:127.0.0.1:49423_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:49423/solr";,
[junit4] 2> "node_name":"127.0.0.1:49423_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1440435 INFO
(OverseerStateUpdate-72088897977974789-127.0.0.1:49423_solr-n_0000000000)
[n:127.0.0.1:49423_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:49423/solr";,
[junit4] 2> "node_name":"127.0.0.1:49423_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1440709 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_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> 1440709 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_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> 1440709 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_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> 1440727 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_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> 1440727 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_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> 1440727 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_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> 1440750 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1440763 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1440763 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1440936 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_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> 1440936 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_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> 1440936 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_49424.solr.core.testScheduledTrigger.shard1.replica_n1'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n1') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@17671c4f
[junit4] 2> 1440936 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.SolrCore
[[testScheduledTrigger_shard1_replica_n1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_884D92427B6B08BA-001\tempDir-001\node1\.\testScheduledTrigger_shard1_replica_n1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_884D92427B6B08BA-001\tempDir-001\node1\.\testScheduledTrigger_shard1_replica_n1\data\]
[junit4] 2> 1440941 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_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> 1440941 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_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> 1440942 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_49423.solr.core.testScheduledTrigger.shard1.replica_n2'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n2') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@17671c4f
[junit4] 2> 1440943 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.SolrCore
[[testScheduledTrigger_shard1_replica_n2] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_884D92427B6B08BA-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n2],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_884D92427B6B08BA-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n2\data\]
[junit4] 2> 1440945 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_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> 1440945 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_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> 1440945 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_49423.solr.core.testScheduledTrigger.shard1.replica_n4'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n4') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@17671c4f
[junit4] 2> 1440945 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.c.SolrCore
[[testScheduledTrigger_shard1_replica_n4] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_884D92427B6B08BA-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n4],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_884D92427B6B08BA-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n4\data\]
[junit4] 2> 1441030 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_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> 1441030 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_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> 1441033 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_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> 1441033 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1441035 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_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> 1441036 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_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> 1441036 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_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> 1441037 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_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> 1441037 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1441037 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_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> 1441038 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_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> 1441038 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_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 1667443799070081024
[junit4] 2> 1441040 INFO
(searcherExecutor-14771-thread-1-processing-n:127.0.0.1:49423_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:49423_solr c:testScheduledTrigger s:shard1
r:core_node5 x:testScheduledTrigger_shard1_replica_n2 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1441040 INFO
(searcherExecutor-14771-thread-1-processing-n:127.0.0.1:49423_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:49423_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> 1441041 INFO
(searcherExecutor-14771-thread-1-processing-n:127.0.0.1:49423_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:49423_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> 1441043 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.ZkShardTerms Successful
update of terms at /collections/testScheduledTrigger/terms/shard1 to
Terms{values={core_node5=0}, version=0}
[junit4] 2> 1441043 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_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> 1441046 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_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> 1441046 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_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> 1441049 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_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> 1441049 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1441049 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContext
Waiting until we see more replicas up for shard shard1: total=3 found=1
timeoute in=9999ms
[junit4] 2> 1441051 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_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> 1441051 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_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> 1441052 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_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> 1441053 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_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> 1441053 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_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> 1441053 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_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> 1441053 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1441053 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_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> 1441053 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_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> 1441053 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1441055 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_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> 1441055 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_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 1667443799087906816
[junit4] 2> 1441056 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_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> 1441056 INFO
(searcherExecutor-14769-thread-1-processing-n:127.0.0.1:49424_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:49424_solr c:testScheduledTrigger s:shard1
r:core_node3 x:testScheduledTrigger_shard1_replica_n1 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1441056 INFO
(searcherExecutor-14769-thread-1-processing-n:127.0.0.1:49424_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:49424_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> 1441056 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_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> 1441056 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_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> 1441058 INFO
(searcherExecutor-14769-thread-1-processing-n:127.0.0.1:49424_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:49424_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> 1441058 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_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> 1441058 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1441058 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_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> 1441058 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_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> 1441060 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_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 1667443799093149696
[junit4] 2> 1441060 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful
update of terms at /collections/testScheduledTrigger/terms/shard1 to
Terms{values={core_node3=0, core_node5=0}, version=1}
[junit4] 2> 1441061 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_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> 1441061 INFO
(searcherExecutor-14773-thread-1-processing-n:127.0.0.1:49423_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:49423_solr c:testScheduledTrigger s:shard1
r:core_node6 x:testScheduledTrigger_shard1_replica_n4 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1441061 INFO
(searcherExecutor-14773-thread-1-processing-n:127.0.0.1:49423_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:49423_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> 1441063 INFO
(searcherExecutor-14773-thread-1-processing-n:127.0.0.1:49423_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:49423_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> 1441063 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_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> 1441063 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_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> 1441368 DEBUG (ScheduledTrigger-14747-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> 1441726 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContext
Enough replicas found to continue.
[junit4] 2> 1441726 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContext I
may be the new leader - try and sync
[junit4] 2> 1441726 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.SyncStrategy Sync replicas
to http://127.0.0.1:49423/solr/testScheduledTrigger_shard1_replica_n2/
[junit4] 2> 1441728 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.u.PeerSync PeerSync:
core=testScheduledTrigger_shard1_replica_n2 url=http://127.0.0.1:49423/solr
START
replicas=[http://127.0.0.1:49424/solr/testScheduledTrigger_shard1_replica_n1/,
http://127.0.0.1:49423/solr/testScheduledTrigger_shard1_replica_n4/]
nUpdates=100
[junit4] 2> 1441729 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.u.PeerSync PeerSync:
core=testScheduledTrigger_shard1_replica_n2 url=http://127.0.0.1:49423/solr
DONE. We have no versions. sync failed.
[junit4] 2> 1441730 INFO (qtp1999654931-23223) [n:127.0.0.1:49424_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.S.Request
[testScheduledTrigger_shard1_replica_n1] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 1441730 INFO (qtp1284261330-23220) [n:127.0.0.1:49423_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> 1441731 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.SyncStrategy Leader's
attempt to sync with shard failed, moving to the next candidate
[junit4] 2> 1441731 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] 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> 1441731 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
/collections/testScheduledTrigger/leaders/shard1/leader after winning as
/collections/testScheduledTrigger/leader_elect/shard1/election/72088897977974789-core_node5-n_0000000000
[junit4] 2> 1441734 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContext I
am the new leader:
http://127.0.0.1:49423/solr/testScheduledTrigger_shard1_replica_n2/ shard1
[junit4] 2> 1441874 INFO (zkCallback-14730-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> 1441874 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.ZkController I am the
leader, no recovery necessary
[junit4] 2> 1441882 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_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=868
[junit4] 2> 1442014 INFO (zkCallback-14730-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> 1442014 INFO (zkCallback-14730-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> 1442421 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_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=1269
[junit4] 2> 1442421 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_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=1269
[junit4] 2> 1442423 DEBUG
(OverseerThreadFactory-14749-thread-1-processing-n:127.0.0.1:49423_solr)
[n:127.0.0.1:49423_solr ] o.a.s.c.s.c.a.PolicyHelper session set to NULL
[junit4] 2> 1442425 INFO (qtp1284261330-23222) [n:127.0.0.1:49423_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> 1442543 INFO (zkCallback-14730-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> 1442543 INFO (zkCallback-14730-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> 1442544 INFO (zkCallback-14743-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> 1442544 INFO (zkCallback-14743-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> 1442544 INFO (qtp1284261330-23222) [n:127.0.0.1:49423_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=1774
[junit4] 2> 1442545 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection:
testScheduledTrigger
[junit4] 2> 1442550 INFO (qtp1284261330-23216) [n:127.0.0.1:49423_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> 1442552 INFO (qtp1284261330-23218) [n:127.0.0.1:49423_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=1
[junit4] 2> 1442552 INFO (qtp1999654931-23219) [n:127.0.0.1:49424_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> 1442555 INFO (qtp1999654931-23224) [n:127.0.0.1:49424_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=1
[junit4] 2> 1442556 DEBUG (qtp1999654931-23221) [n:127.0.0.1:49424_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1442557 INFO (qtp1999654931-23221) [n:127.0.0.1:49424_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=7
[junit4] 2> 1442557 DEBUG (zkCallback-14730-thread-2) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
3
[junit4] 2> 1442557 DEBUG
(OverseerAutoScalingTriggerThread-72088897977974789-127.0.0.1:49423_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 3
[junit4] 2> 1442558 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding
port=0)
[junit4] 2> 1442558 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number
2 ...
[junit4] 2> 1442558 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.e.j.s.Server jetty-9.4.27.v20200227; built:
2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm
13.0.2+8
[junit4] 2> 1442558 DEBUG
(OverseerAutoScalingTriggerThread-72088897977974789-127.0.0.1:49423_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1442559 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1442559 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1442559 DEBUG
(OverseerAutoScalingTriggerThread-72088897977974789-127.0.0.1:49423_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3,
lastZnodeVersion 3
[junit4] 2> 1442559 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1442559 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1e902e{/solr,null,AVAILABLE}
[junit4] 2> 1442561 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.e.j.s.AbstractConnector Started ServerConnector@42aa6569{HTTP/1.1,
(http/1.1, h2c)}{127.0.0.1:49576}
[junit4] 2> 1442561 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.e.j.s.Server Started @1388226ms
[junit4] 2> 1442561 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=49576}
[junit4] 2> 1442562 ERROR
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging
may be missing or incomplete.
[junit4] 2> 1442562 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1442562 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr?
version 9.0.0
[junit4] 2> 1442562 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on
port null
[junit4] 2> 1442562 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
[junit4] 2> 1442562 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-05-23T01:45:26.748442500Z
[junit4] 2> 1442563 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1442566 INFO (zkConnectionManagerCallback-14787-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1442566 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1442566 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1442691 DEBUG (ScheduledTrigger-14747-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> 1442697 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1442699 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.e.j.u.s.S.config Trusting all certificates configured for
Client@1f51f726[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1442699 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm
configured for Client@1f51f726[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1442704 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.e.j.u.s.S.config Trusting all certificates configured for
Client@5eb9bb49[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1442704 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm
configured for Client@5eb9bb49[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1442706 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:49410/solr
[junit4] 2> 1442708 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[n:127.0.0.1:49576_solr ] o.a.s.c.c.ConnectionManager Waiting for client
to connect to ZooKeeper
[junit4] 2> 1442710 INFO (zkConnectionManagerCallback-14798-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1442710 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[n:127.0.0.1:49576_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1442716 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[n:127.0.0.1:49576_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 1442719 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[n:127.0.0.1:49576_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:49576_solr as DOWN
[junit4] 2> 1442720 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[n:127.0.0.1:49576_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 1000 transient cores
[junit4] 2> 1442720 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[n:127.0.0.1:49576_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:49576_solr
[junit4] 2> 1442722 INFO (zkCallback-14743-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1442722 INFO (zkCallback-14730-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1442722 INFO (zkCallback-14766-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1442722 INFO (zkCallback-14797-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1442725 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[n:127.0.0.1:49576_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1442725 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[n:127.0.0.1:49576_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> 1442750 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[n:127.0.0.1:49576_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1442781 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[n:127.0.0.1:49576_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49576.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@17671c4f
[junit4] 2> 1442806 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[n:127.0.0.1:49576_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49576.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@17671c4f
[junit4] 2> 1442806 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[n:127.0.0.1:49576_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49576.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@17671c4f
[junit4] 2> 1442808 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[n:127.0.0.1:49576_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_884D92427B6B08BA-001\tempDir-001\node3\.
[junit4] 2> 1442828 INFO
(OverseerCollectionConfigSetProcessor-72088897977974789-127.0.0.1:49423_solr-n_0000000000)
[n:127.0.0.1:49423_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> 1442832 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=3
[junit4] 2> 1442837 INFO (qtp1284261330-23220) [n:127.0.0.1:49423_solr
] o.a.s.s.HttpSolrCall [admin] we
[...truncated too long message...]
a.ScheduledTriggers ScheduledTriggers closed completely
[junit4] 2> 1488615 DEBUG (closeThreadPool-14824-thread-2) [ ]
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
[junit4] 2> 1488615 INFO (closeThreadPool-14824-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72088897977974789-127.0.0.1:49423_solr-n_0000000000) closing
[junit4] 2> 1488674 INFO (zkCallback-14743-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 1488674 INFO (zkCallback-14730-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 1488675 INFO (jetty-closer-14807-thread-3) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@42aa6569{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 1488675 INFO (jetty-closer-14807-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@1e902e{/solr,null,UNAVAILABLE}
[junit4] 2> 1488676 INFO (jetty-closer-14807-thread-3) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1488756 INFO (jetty-closer-14807-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@79f7a085{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 1488756 INFO (jetty-closer-14807-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@6ebaef62{/solr,null,UNAVAILABLE}
[junit4] 2> 1488757 INFO (jetty-closer-14807-thread-2) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1488835 INFO (jetty-closer-14807-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72088897977974789-127.0.0.1:49423_solr-n_0000000000) closing
[junit4] 2> 1488836 INFO (jetty-closer-14807-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@424ba233{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 1488837 INFO (jetty-closer-14807-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@79b9ca91{/solr,null,UNAVAILABLE}
[junit4] 2> 1488837 INFO (jetty-closer-14807-thread-1) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1488837 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 1489000 WARN (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 7
/solr/collections/testScheduledTrigger/terms/shard1
[junit4] 2> 4 /solr/aliases.json
[junit4] 2> 4 /solr/clusterprops.json
[junit4] 2> 3
/solr/configs/testScheduledTrigger.AUTOCREATED/managed-schema
[junit4] 2> 3 /solr/packages.json
[junit4] 2> 3 /solr/security.json
[junit4] 2> 2 /solr/configs/testScheduledTrigger.AUTOCREATED
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 21
/solr/collections/testScheduledTrigger/state.json
[junit4] 2> 4 /solr/clusterstate.json
[junit4] 2> 4 /solr/autoscaling.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 23 /solr/overseer/queue
[junit4] 2> 13 /solr/live_nodes
[junit4] 2> 7 /solr/collections
[junit4] 2> 4 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> 1489006 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:49410
[junit4] 2> 1489006 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:49410
[junit4] 2> 1489006 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 49410
[junit4] 2> 1490602 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[884D92427B6B08BA])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testScheduledTrigger
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=ScheduledTriggerIntegrationTest -Dtests.method=testScheduledTrigger
-Dtests.seed=884D92427B6B08BA -Dtests.slow=true -Dtests.locale=yo-NG
-Dtests.timezone=Asia/Gaza -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] FAILURE 51.2s J3 |
ScheduledTriggerIntegrationTest.testScheduledTrigger <<<
[junit4] > Throwable #1: java.lang.AssertionError: ScheduledTrigger did
not fire in time
[junit4] > at
__randomizedtesting.SeedInfo.seed([884D92427B6B08BA:1B56DA302596538E]:0)
[junit4] > at
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest.testScheduledTrigger(ScheduledTriggerIntegrationTest.java:120)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] > at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at
java.base/java.lang.reflect.Method.invoke(Method.java:567)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:830)
[junit4] 2> NOTE: leaving temporary files on disk at:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_884D92427B6B08BA-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene86): {},
docValues:{}, maxPointsInLeafNode=1374, maxMBSortInHeap=7.573056229752805,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@19aa8dab),
locale=yo-NG, timezone=Asia/Gaza
[junit4] 2> NOTE: Windows 10 10.0 amd64/AdoptOpenJDK 13.0.2
(64-bit)/cpus=6,threads=1,free=188643544,total=414187520
[junit4] 2> NOTE: All tests run in this JVM:
[TestSimpleTrackingShardHandler, TestJsonRequest, TestCryptoKeys,
BasicAuthStandaloneTest, TestSubQueryTransformerDistrib, SimpleFacetsTest,
DistributedFacetPivotSmallTest, JavaBinAtomicUpdateMultivalueTest,
TestDistributedStatsComponentCardinality, TestNumericTerms64,
TestFieldTypeCollectionResource, TestLRUStatsCacheCloud,
FileBasedSpellCheckerTest, AssignTest, TestRealTimeGet,
TestCustomDocTransformer, TestAuthenticationFramework,
AutoAddReplicasPlanActionTest, TestFieldCacheSortRandom, TriggerEventQueueTest,
TestCollationField, ShardSplitTest, XMLAtomicUpdateMultivalueTest,
TestReversedWildcardFilterFactory, TestFileDictionaryLookup, TestLRUStatsCache,
TaggerTest, ClassificationUpdateProcessorIntegrationTest,
DistribCursorPagingTest, HdfsSyncSliceTest, RestartWhileUpdatingTest,
PeerSyncWithBufferUpdatesTest, AddReplicaTest, BitVectorTest,
TestSafeXMLParsing, QueryResultKeyTest, SolrCloudReportersTest,
SolrMetricsIntegrationTest, HdfsChaosMonkeySafeLeaderTest, IndexSchemaTest,
SearchRateTriggerIntegrationTest, TestCoreContainer, TestConfigsApi,
FuzzySearchTest, CoreSorterTest, TestExportTool, TestStressReorder,
CopyFieldTest, TestDynamicFieldNamesIndexCorrectly,
SolrCoreCheckLockOnStartupTest, TestDFISimilarityFactory,
TestSimTriggerIntegration, NoCacheHeaderTest, TestComplexPhraseQParserPlugin,
CdcrBootstrapTest, TestSchemaVersionResource, TestXIncludeConfig,
TestQueryingOnDownCollection, MetricTriggerTest, TolerantUpdateProcessorTest,
TestUtils, TestHdfsCloudBackupRestore, ResponseLogComponentTest,
SynonymTokenizerTest, MoveReplicaHDFSTest, SplitHandlerTest,
CloudReplicaSourceTest, TestGraphTermsQParserPlugin, UUIDFieldTest,
SpatialFilterTest, HttpPartitionTest, TestQueryUtils, TestRequestForwarding,
JvmMetricsTest, TestQuerySenderListener, ImplicitSnitchTest,
CdcrWithNodesRestartsTest, TestCopyFieldCollectionResource, PrimUtilsTest,
TestJsonFacetErrors, DataDrivenBlockJoinTest, TestSQLHandlerNonCloud,
TestLegacyBM25SimilarityFactory, TestSolrCloudWithHadoopAuthPlugin,
ConfigSetsAPITest, TestCSVLoader, TestSearchPerf, EchoParamsTest,
MinimalSchemaTest, OutputWriterTest, SampleTest, SolrInfoBeanTest,
SolrTestCaseJ4Test, TestCrossCoreJoin, TestCursorMarkWithoutUniqueKey,
TestDistributedGrouping, BasicDistributedZkTest, CollectionsAPISolrJTest,
RecoveryAfterSoftCommitTest, SharedFSAutoReplicaFailoverTest, SliceStateTest,
SolrCLIZkUtilsTest, SolrXmlInZkTest, TestCloudConsistency, TestPrepRecovery,
TestRebalanceLeaders, TlogReplayBufferedWhileIndexingTest,
TriLevelCompositeIdRoutingTest, ZkControllerTest,
ConcurrentDeleteAndCreateCollectionTest, CustomCollectionTest,
TestCollectionsAPIViaSolrCloudCluster, AutoAddReplicasIntegrationTest,
NodeMarkersRegistrationTest, ScheduledTriggerIntegrationTest]
[junit4] Completed [629/913 (1!)] on J3 in 51.23s, 1 test, 1 failure <<<
FAILURES!
[...truncated 53273 lines...]
[repro] Jenkins log URL:
https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/8868/consoleText
[repro] Revision: 675956c0041b18d48a7c059ea458c49f5310d74a
[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseParallelGC"
[repro] JUnit rest result XML files will be moved to: ./repro-reports
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr\core
[repro] ScheduledTriggerIntegrationTest
[repro] ant compile-test
[...truncated 3158 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5
-Dtests.class="*.ScheduledTriggerIntegrationTest" -Dtests.showOutput=onerror
"-Dargs=-XX:+UseCompressedOops -XX:+UseParallelGC"
-Dtests.seed=884D92427B6B08BA -Dtests.slow=true -Dtests.locale=yo-NG
-Dtests.timezone=Asia/Gaza -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[...truncated 82 lines...]
[repro] Failures w/original seeds:
[repro] 0/5 failed:
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest
[repro] Exiting with code 0
[...truncated 78 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: builds-unsubscr...@lucene.apache.org
For additional commands, e-mail: builds-h...@lucene.apache.org
