Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-MacOSX/1462/
Java: 64bit/jdk-11.0.6 -XX:+UseCompressedOops -XX:+UseSerialGC
1 tests failed.
FAILED:
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest.testScheduledTrigger
Error Message:
Stack Trace:
java.lang.AssertionError
at
__randomizedtesting.SeedInfo.seed([9C57F6DBAB1992B3:F4CBEA9F5E4C987]:0)
at org.junit.Assert.fail(Assert.java:86)
at org.junit.Assert.assertTrue(Assert.java:41)
at org.junit.Assert.assertNotNull(Assert.java:712)
at org.junit.Assert.assertNotNull(Assert.java:722)
at
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest.testScheduledTrigger(ScheduledTriggerIntegrationTest.java:128)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:566)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:834)
Build Log:
[...truncated 15411 lines...]
[junit4] Suite:
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest
[junit4] 2> 1928262 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[9C57F6DBAB1992B3]-worker) [ ]
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to
test-framework derived value of
'/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/server/solr/configsets/_default/conf'
[junit4] 2> 1928263 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[9C57F6DBAB1992B3]-worker) [ ]
o.a.s.SolrTestCaseJ4 Created dataDir:
/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_9C57F6DBAB1992B3-001/data-dir-108-001
[junit4] 2> 1928263 WARN
(SUITE-ScheduledTriggerIntegrationTest-seed#[9C57F6DBAB1992B3]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=28 numCloses=28
[junit4] 2> 1928263 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[9C57F6DBAB1992B3]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1928264 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[9C57F6DBAB1992B3]-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) w/ MAC_OS_X supressed clientAuth
[junit4] 2> 1928264 INFO
(SUITE-ScheduledTriggerIntegrationTest-seed#[9C57F6DBAB1992B3]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1928265 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testScheduledTrigger
[junit4] 2> 1928266 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in
/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_9C57F6DBAB1992B3-001/tempDir-001
[junit4] 2> 1928266 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1928266 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 1928266 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1928268 WARN (ZkTestServer Run Thread) [ ]
o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 1928366 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.ZkTestServer start zk server on port: 62885
[junit4] 2> 1928366 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:62885
[junit4] 2> 1928366 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:62885
[junit4] 2> 1928366 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 62885
[junit4] 2> 1928370 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1928374 INFO (zkConnectionManagerCallback-19484-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1928374 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1928377 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1928381 INFO (zkConnectionManagerCallback-19486-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1928381 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1928381 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1928385 INFO (zkConnectionManagerCallback-19488-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1928385 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1928388 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3]-SendThread(127.0.0.1:62885))
[ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for
session 0x1000775b08e0002.
[junit4] 2> => EndOfStreamException: Unable to read additional
data from server sessionid 0x1000775b08e0002, likely server has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable
to read additional data from server sessionid 0x1000775b08e0002, likely server
has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75)
~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:348)
~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1262)
[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> 1928490 WARN (jetty-launcher-19489-thread-1) [ ]
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content,
break even is size 23
[junit4] 2> 1928490 WARN (jetty-launcher-19489-thread-2) [ ]
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content,
break even is size 23
[junit4] 2> 1928490 INFO (jetty-launcher-19489-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1928490 INFO (jetty-launcher-19489-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1928490 INFO (jetty-launcher-19489-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1928490 INFO (jetty-launcher-19489-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1928490 INFO (jetty-launcher-19489-thread-1) [ ]
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git:
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 11.0.6+10
[junit4] 2> 1928490 INFO (jetty-launcher-19489-thread-2) [ ]
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git:
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 11.0.6+10
[junit4] 2> 1928493 INFO (jetty-launcher-19489-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1928493 INFO (jetty-launcher-19489-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1928493 INFO (jetty-launcher-19489-thread-2) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1928493 INFO (jetty-launcher-19489-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1928493 INFO (jetty-launcher-19489-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1928493 INFO (jetty-launcher-19489-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1928494 INFO (jetty-launcher-19489-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1430ba8a{/solr,null,AVAILABLE}
[junit4] 2> 1928494 INFO (jetty-launcher-19489-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7e3d83a0{/solr,null,AVAILABLE}
[junit4] 2> 1928494 INFO (jetty-launcher-19489-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@148214e3{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:62892}
[junit4] 2> 1928494 INFO (jetty-launcher-19489-thread-1) [ ]
o.e.j.s.Server Started @1928586ms
[junit4] 2> 1928494 INFO (jetty-launcher-19489-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@76d9fb{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:62891}
[junit4] 2> 1928494 INFO (jetty-launcher-19489-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=62892}
[junit4] 2> 1928494 INFO (jetty-launcher-19489-thread-2) [ ]
o.e.j.s.Server Started @1928586ms
[junit4] 2> 1928494 INFO (jetty-launcher-19489-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=62891}
[junit4] 2> 1928494 ERROR (jetty-launcher-19489-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1928494 INFO (jetty-launcher-19489-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1928495 INFO (jetty-launcher-19489-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.7.0
[junit4] 2> 1928495 ERROR (jetty-launcher-19489-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1928495 INFO (jetty-launcher-19489-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1928495 INFO (jetty-launcher-19489-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1928495 INFO (jetty-launcher-19489-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr
[junit4] 2> 1928495 INFO (jetty-launcher-19489-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-09-06T04:04:54.457089Z
[junit4] 2> 1928495 INFO (jetty-launcher-19489-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.7.0
[junit4] 2> 1928495 INFO (jetty-launcher-19489-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1928495 INFO (jetty-launcher-19489-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr
[junit4] 2> 1928495 INFO (jetty-launcher-19489-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-09-06T04:04:54.457196Z
[junit4] 2> 1928496 INFO (jetty-launcher-19489-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1928496 INFO (jetty-launcher-19489-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1928498 INFO (zkConnectionManagerCallback-19493-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1928499 INFO (jetty-launcher-19489-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1928499 INFO (zkConnectionManagerCallback-19491-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1928499 INFO (jetty-launcher-19489-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1928499 INFO (jetty-launcher-19489-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1928500 INFO (jetty-launcher-19489-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1928504 WARN
(jetty-launcher-19489-thread-1-SendThread(127.0.0.1:62885)) [ ]
o.a.z.ClientCnxn An exception was thrown while closing send thread for session
0x1000775b08e0004.
[junit4] 2> => EndOfStreamException: Unable to read additional
data from server sessionid 0x1000775b08e0004, likely server has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable
to read additional data from server sessionid 0x1000775b08e0004, likely server
has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75)
~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:348)
~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1262)
[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> 1928504 WARN
(jetty-launcher-19489-thread-2-SendThread(127.0.0.1:62885)) [ ]
o.a.z.ClientCnxn An exception was thrown while closing send thread for session
0x1000775b08e0003.
[junit4] 2> => EndOfStreamException: Unable to read additional
data from server sessionid 0x1000775b08e0003, likely server has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable
to read additional data from server sessionid 0x1000775b08e0003, likely server
has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75)
~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:348)
~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1262)
[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> 1928694 INFO (jetty-launcher-19489-thread-1) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1928695 WARN (jetty-launcher-19489-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@1d12cfa2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1928695 WARN (jetty-launcher-19489-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@1d12cfa2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1928697 WARN (jetty-launcher-19489-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@25e6da51[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1928697 WARN (jetty-launcher-19489-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@25e6da51[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1928697 INFO (jetty-launcher-19489-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:62885/solr
[junit4] 2> 1928698 INFO (jetty-launcher-19489-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1928701 INFO (zkConnectionManagerCallback-19503-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1928701 INFO (jetty-launcher-19489-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1928703 WARN
(jetty-launcher-19489-thread-1-SendThread(127.0.0.1:62885)) [ ]
o.a.z.ClientCnxn An exception was thrown while closing send thread for session
0x1000775b08e0005.
[junit4] 2> => EndOfStreamException: Unable to read additional
data from server sessionid 0x1000775b08e0005, likely server has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable
to read additional data from server sessionid 0x1000775b08e0005, likely server
has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75)
~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:348)
~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1262)
[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> 1928773 INFO (jetty-launcher-19489-thread-2) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1928774 WARN (jetty-launcher-19489-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@290f5711[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1928774 WARN (jetty-launcher-19489-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@290f5711[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1928776 WARN (jetty-launcher-19489-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@76e947f3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1928776 WARN (jetty-launcher-19489-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@76e947f3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1928776 INFO (jetty-launcher-19489-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:62885/solr
[junit4] 2> 1928777 INFO (jetty-launcher-19489-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1928780 INFO (zkConnectionManagerCallback-19513-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1928780 INFO (jetty-launcher-19489-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1928782 WARN
(jetty-launcher-19489-thread-2-SendThread(127.0.0.1:62885)) [ ]
o.a.z.ClientCnxn An exception was thrown while closing send thread for session
0x1000775b08e0006.
[junit4] 2> => EndOfStreamException: Unable to read additional
data from server sessionid 0x1000775b08e0006, likely server has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable
to read additional data from server sessionid 0x1000775b08e0006, likely server
has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75)
~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:348)
~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1262)
[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> 1928815 INFO (jetty-launcher-19489-thread-1)
[n:127.0.0.1:62892_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1928818 INFO (zkConnectionManagerCallback-19515-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1928818 INFO (jetty-launcher-19489-thread-1)
[n:127.0.0.1:62892_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1928916 INFO (jetty-launcher-19489-thread-2)
[n:127.0.0.1:62891_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1928920 INFO (zkConnectionManagerCallback-19519-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1928920 INFO (jetty-launcher-19489-thread-2)
[n:127.0.0.1:62891_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 1928966 INFO (jetty-launcher-19489-thread-2)
[n:127.0.0.1:62891_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:62891_solr
[junit4] 2> 1928970 INFO (jetty-launcher-19489-thread-2)
[n:127.0.0.1:62891_solr ] o.a.s.c.Overseer Overseer
(id=72065796092592136-127.0.0.1:62891_solr-n_0000000000) starting
[junit4] 2> 1928997 INFO
(OverseerStateUpdate-72065796092592136-127.0.0.1:62891_solr-n_0000000000)
[n:127.0.0.1:62891_solr ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:62891_solr
[junit4] 2> 1928998 INFO (jetty-launcher-19489-thread-2)
[n:127.0.0.1:62891_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:62891_solr
[junit4] 2> 1929001 DEBUG
(OverseerAutoScalingTriggerThread-72065796092592136-127.0.0.1:62891_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and
.scheduled_maintenance triggers
[junit4] 2> 1929004 INFO
(OverseerStateUpdate-72065796092592136-127.0.0.1:62891_solr-n_0000000000)
[n:127.0.0.1:62891_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1929006 DEBUG
(OverseerAutoScalingTriggerThread-72065796092592136-127.0.0.1:62891_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with
znode version 1
[junit4] 2> 1929006 DEBUG
(OverseerAutoScalingTriggerThread-72065796092592136-127.0.0.1:62891_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1,
lastZnodeVersion 0
[junit4] 2> 1929006 DEBUG
(OverseerAutoScalingTriggerThread-72065796092592136-127.0.0.1:62891_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 1
[junit4] 2> 1929013 INFO (jetty-launcher-19489-thread-2)
[n:127.0.0.1:62891_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1929013 WARN (jetty-launcher-19489-thread-2)
[n:127.0.0.1:62891_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> 1929022 DEBUG
(OverseerAutoScalingTriggerThread-72065796092592136-127.0.0.1:62891_solr-n_0000000000)
[ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial
livenodes: [127.0.0.1:62891_solr]
[junit4] 2> 1929024 DEBUG
(OverseerAutoScalingTriggerThread-72065796092592136-127.0.0.1:62891_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1929027 DEBUG (ScheduledTrigger-19524-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> 1929027 DEBUG
(OverseerAutoScalingTriggerThread-72065796092592136-127.0.0.1:62891_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1,
lastZnodeVersion 1
[junit4] 2> 1929035 INFO (jetty-launcher-19489-thread-2)
[n:127.0.0.1:62891_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1929053 INFO (jetty-launcher-19489-thread-1)
[n:127.0.0.1:62892_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1929060 INFO (jetty-launcher-19489-thread-2)
[n:127.0.0.1:62891_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_62891.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3d0d374f
[junit4] 2> 1929063 INFO (jetty-launcher-19489-thread-1)
[n:127.0.0.1:62892_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:62892_solr as DOWN
[junit4] 2> 1929066 INFO (jetty-launcher-19489-thread-1)
[n:127.0.0.1:62892_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 1929066 INFO (jetty-launcher-19489-thread-1)
[n:127.0.0.1:62892_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:62892_solr
[junit4] 2> 1929069 INFO (zkCallback-19518-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1929070 INFO (zkCallback-19514-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1929070 INFO (jetty-launcher-19489-thread-2)
[n:127.0.0.1:62891_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_62891.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3d0d374f
[junit4] 2> 1929070 INFO (jetty-launcher-19489-thread-2)
[n:127.0.0.1:62891_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_62891.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3d0d374f
[junit4] 2> 1929071 INFO (jetty-launcher-19489-thread-2)
[n:127.0.0.1:62891_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_9C57F6DBAB1992B3-001/tempDir-001/node2
[junit4] 2> 1929072 INFO (jetty-launcher-19489-thread-1)
[n:127.0.0.1:62892_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 1929072 WARN (jetty-launcher-19489-thread-1)
[n:127.0.0.1:62892_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> 1929088 INFO (jetty-launcher-19489-thread-1)
[n:127.0.0.1:62892_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1929122 INFO (jetty-launcher-19489-thread-1)
[n:127.0.0.1:62892_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_62892.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3d0d374f
[junit4] 2> 1929128 INFO (jetty-launcher-19489-thread-1)
[n:127.0.0.1:62892_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_62892.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3d0d374f
[junit4] 2> 1929128 INFO (jetty-launcher-19489-thread-1)
[n:127.0.0.1:62892_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_62892.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3d0d374f
[junit4] 2> 1929129 INFO (jetty-launcher-19489-thread-1)
[n:127.0.0.1:62892_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_9C57F6DBAB1992B3-001/tempDir-001/node1
[junit4] 2> 1929136 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
[junit4] 2> 1929137 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1929139 INFO (zkConnectionManagerCallback-19542-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1929139 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1929142 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1929144 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at
127.0.0.1:62885/solr ready
[junit4] 2> 1929155 INFO (qtp246490717-30764) [n:127.0.0.1:62891_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 1929158 INFO (qtp246490717-30763) [n:127.0.0.1:62891_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 1929158 INFO (qtp246490717-30763) [n:127.0.0.1:62891_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=0
[junit4] 2> 1929160 INFO (qtp440793563-30761) [n:127.0.0.1:62892_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=0
[junit4] 2> 1929161 DEBUG (qtp246490717-30765) [n:127.0.0.1:62891_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1929162 INFO (qtp246490717-30765) [n:127.0.0.1:62891_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=6
[junit4] 2> 1929163 DEBUG (zkCallback-19518-thread-1) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
2
[junit4] 2> 1929163 DEBUG
(OverseerAutoScalingTriggerThread-72065796092592136-127.0.0.1:62891_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 2
[junit4] 2> 1929163 INFO (qtp246490717-30766) [n:127.0.0.1:62891_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> 1929168 DEBUG
(OverseerAutoScalingTriggerThread-72065796092592136-127.0.0.1:62891_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1929171 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
testScheduledTrigger
[junit4] 2> 1929171 DEBUG
(OverseerAutoScalingTriggerThread-72065796092592136-127.0.0.1:62891_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2,
lastZnodeVersion 2
[junit4] 2> 1929173 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/managed-schema to
/configs/testScheduledTrigger.AUTOCREATED/managed-schema
[junit4] 2> 1929177 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/protwords.txt to
/configs/testScheduledTrigger.AUTOCREATED/protwords.txt
[junit4] 2> 1929181 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929186 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929191 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929196 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929202 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929206 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929213 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929217 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929221 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929226 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929230 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929235 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929239 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929244 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929249 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929253 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929259 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929263 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929268 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929272 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929277 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929282 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929286 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929290 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929294 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929299 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929303 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929308 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929312 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929317 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929320 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929328 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929333 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929338 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929343 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929349 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929355 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929360 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929365 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929370 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/solrconfig.xml to
/configs/testScheduledTrigger.AUTOCREATED/solrconfig.xml
[junit4] 2> 1929374 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/synonyms.txt to
/configs/testScheduledTrigger.AUTOCREATED/synonyms.txt
[junit4] 2> 1929379 INFO
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/stopwords.txt to
/configs/testScheduledTrigger.AUTOCREATED/stopwords.txt
[junit4] 2> 1929496 WARN
(OverseerThreadFactory-19526-thread-1-processing-n:127.0.0.1:62891_solr)
[n:127.0.0.1:62891_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> 1929507 INFO
(OverseerStateUpdate-72065796092592136-127.0.0.1:62891_solr-n_0000000000)
[n:127.0.0.1:62891_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:62891/solr";,
[junit4] 2> "node_name":"127.0.0.1:62891_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1929514 INFO
(OverseerStateUpdate-72065796092592136-127.0.0.1:62891_solr-n_0000000000)
[n:127.0.0.1:62891_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:62892/solr";,
[junit4] 2> "node_name":"127.0.0.1:62892_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1929521 INFO
(OverseerStateUpdate-72065796092592136-127.0.0.1:62891_solr-n_0000000000)
[n:127.0.0.1:62891_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:62891/solr";,
[junit4] 2> "node_name":"127.0.0.1:62891_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1929730 INFO (qtp246490717-30763) [n:127.0.0.1:62891_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> 1929730 INFO (qtp246490717-30764) [n:127.0.0.1:62891_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> 1929730 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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> 1929752 INFO (qtp440793563-30758) [n:127.0.0.1:62892_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 8.7.0
[junit4] 2> 1929752 INFO (qtp246490717-30763) [n:127.0.0.1:62891_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 8.7.0
[junit4] 2> 1929758 INFO (qtp246490717-30764) [n:127.0.0.1:62891_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 8.7.0
[junit4] 2> 1929775 INFO (qtp440793563-30758) [n:127.0.0.1:62892_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1929777 INFO (qtp246490717-30763) [n:127.0.0.1:62891_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1929800 INFO (qtp246490717-30764) [n:127.0.0.1:62891_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema
name=default-config
[junit4] 2> 1930033 DEBUG (ScheduledTrigger-19524-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> 1930090 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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> 1930092 INFO (qtp246490717-30763) [n:127.0.0.1:62891_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> 1930098 INFO (qtp246490717-30764) [n:127.0.0.1:62891_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> 1930211 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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> 1930211 INFO (qtp440793563-30758) [n:127.0.0.1:62892_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_62892.solr.core.testScheduledTrigger.shard1.replica_n2'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n2') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@3d0d374f
[junit4] 2> 1930211 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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
[/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_9C57F6DBAB1992B3-001/tempDir-001/node1/testScheduledTrigger_shard1_replica_n2],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_9C57F6DBAB1992B3-001/tempDir-001/node1/testScheduledTrigger_shard1_replica_n2/data/]
[junit4] 2> 1930216 INFO (qtp246490717-30763) [n:127.0.0.1:62891_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> 1930216 INFO (qtp246490717-30763) [n:127.0.0.1:62891_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_62891.solr.core.testScheduledTrigger.shard1.replica_n4'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n4') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@3d0d374f
[junit4] 2> 1930216 INFO (qtp246490717-30763) [n:127.0.0.1:62891_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
[/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_9C57F6DBAB1992B3-001/tempDir-001/node2/testScheduledTrigger_shard1_replica_n4],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_9C57F6DBAB1992B3-001/tempDir-001/node2/testScheduledTrigger_shard1_replica_n4/data/]
[junit4] 2> 1930231 INFO (qtp246490717-30764) [n:127.0.0.1:62891_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> 1930231 INFO (qtp246490717-30764) [n:127.0.0.1:62891_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_62891.solr.core.testScheduledTrigger.shard1.replica_n1'
(registry 'solr.core.testScheduledTrigger.shard1.replica_n1') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@3d0d374f
[junit4] 2> 1930231 INFO (qtp246490717-30764) [n:127.0.0.1:62891_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
[/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_9C57F6DBAB1992B3-001/tempDir-001/node2/testScheduledTrigger_shard1_replica_n1],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_9C57F6DBAB1992B3-001/tempDir-001/node2/testScheduledTrigger_shard1_replica_n1/data/]
[junit4] 2> 1930274 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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> 1930274 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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> 1930275 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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> 1930275 INFO (qtp440793563-30758) [n:127.0.0.1:62892_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1930281 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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> 1930282 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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> 1930282 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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> 1930284 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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> 1930284 INFO (qtp440793563-30758) [n:127.0.0.1:62892_solr
c:testScheduledTrigger s:shard1 r:core_node5
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1930284 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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> 1930287 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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> 1930287 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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 1677055855164391424
[junit4] 2> 1930288 INFO (qtp246490717-30763) [n:127.0.0.1:62891_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> 1930288 INFO (qtp246490717-30763) [n:127.0.0.1:62891_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> 1930290 INFO (qtp246490717-30763) [n:127.0.0.1:62891_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> 1930290 INFO (qtp246490717-30763) [n:127.0.0.1:62891_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1930291 INFO
(searcherExecutor-19544-thread-1-processing-n:127.0.0.1:62892_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:62892_solr c:testScheduledTrigger s:shard1
r:core_node5 x:testScheduledTrigger_shard1_replica_n2 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1930291 INFO
(searcherExecutor-19544-thread-1-processing-n:127.0.0.1:62892_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:62892_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> 1930292 INFO
(searcherExecutor-19544-thread-1-processing-n:127.0.0.1:62892_solr
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1
r:core_node5) [n:127.0.0.1:62892_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
[junit4] 2> 1930294 INFO (qtp246490717-30763) [n:127.0.0.1:62891_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> 1930296 INFO (qtp246490717-30763) [n:127.0.0.1:62891_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> 1930296 INFO (qtp246490717-30763) [n:127.0.0.1:62891_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> 1930296 INFO (qtp246490717-30763) [n:127.0.0.1:62891_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> 1930296 INFO (qtp246490717-30763) [n:127.0.0.1:62891_solr
c:testScheduledTrigger s:shard1 r:core_node6
x:testScheduledTrigger_shard1_replica_n4 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1930296 INFO (qtp246490717-30763) [n:127.0.0.1:62891_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> 1930301 INFO (qtp246490717-30763) [n:127.0.0.1:62891_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> 1930301 INFO (qtp246490717-30763) [n:127.0.0.1:62891_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 1677055855179071488
[junit4] 2> 1930303 INFO (qtp246490717-30764) [n:127.0.0.1:62891_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> 1930303 INFO (qtp246490717-30764) [n:127.0.0.1:62891_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> 1930303 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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> 1930303 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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> 1930304 INFO
(searcherExecutor-19546-thread-1-processing-n:127.0.0.1:62891_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:62891_solr c:testScheduledTrigger s:shard1
r:core_node6 x:testScheduledTrigger_shard1_replica_n4 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1930305 INFO
(searcherExecutor-19546-thread-1-processing-n:127.0.0.1:62891_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:62891_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> 1930305 INFO
(searcherExecutor-19546-thread-1-processing-n:127.0.0.1:62891_solr
x:testScheduledTrigger_shard1_replica_n4 c:testScheduledTrigger s:shard1
r:core_node6) [n:127.0.0.1:62891_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
[junit4] 2> 1930306 INFO (qtp246490717-30764) [n:127.0.0.1:62891_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> 1930306 INFO (qtp246490717-30764) [n:127.0.0.1:62891_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1930333 INFO (qtp246490717-30764) [n:127.0.0.1:62891_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> 1930334 INFO (qtp246490717-30764) [n:127.0.0.1:62891_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> 1930334 INFO (qtp246490717-30764) [n:127.0.0.1:62891_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> 1930337 INFO (qtp246490717-30764) [n:127.0.0.1:62891_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> 1930337 INFO (qtp246490717-30764) [n:127.0.0.1:62891_solr
c:testScheduledTrigger s:shard1 r:core_node3
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent
Initializing spell checkers
[junit4] 2> 1930337 INFO (qtp246490717-30764) [n:127.0.0.1:62891_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> 1930338 INFO (qtp246490717-30764) [n:127.0.0.1:62891_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> 1930338 INFO (qtp246490717-30764) [n:127.0.0.1:62891_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 1677055855217868800
[junit4] 2> 1930339 INFO (qtp246490717-30763) [n:127.0.0.1:62891_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_node5=0}, version=1}
[junit4] 2> 1930339 INFO (qtp246490717-30763) [n:127.0.0.1:62891_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> 1930341 INFO
(searcherExecutor-19548-thread-1-processing-n:127.0.0.1:62891_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:62891_solr c:testScheduledTrigger s:shard1
r:core_node3 x:testScheduledTrigger_shard1_replica_n1 ]
o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 1930341 INFO
(searcherExecutor-19548-thread-1-processing-n:127.0.0.1:62891_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:62891_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> 1930342 INFO
(searcherExecutor-19548-thread-1-processing-n:127.0.0.1:62891_solr
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1
r:core_node3) [n:127.0.0.1:62891_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
[junit4] 2> 1930343 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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=2
timeoute in=9998ms
[junit4] 2> 1930344 INFO (qtp246490717-30764) [n:127.0.0.1:62891_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_node6=0, core_node3=0, core_node5=0}, version=2}
[junit4] 2> 1930344 INFO (qtp246490717-30764) [n:127.0.0.1:62891_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> 1930847 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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> 1930848 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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> 1930848 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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:62892/solr/testScheduledTrigger_shard1_replica_n2/
[junit4] 2> 1930849 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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:62892/solr
START
replicas=[http://127.0.0.1:62891/solr/testScheduledTrigger_shard1_replica_n1/,
http://127.0.0.1:62891/solr/testScheduledTrigger_shard1_replica_n4/]
nUpdates=100
[junit4] 2> 1930849 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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:62892/solr
DONE. We have no versions. sync failed.
[junit4] 2> 1930852 INFO (qtp246490717-30765) [n:127.0.0.1:62891_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> 1930853 INFO (qtp246490717-30835) [n:127.0.0.1:62891_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> 1930853 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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> 1930853 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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> 1930854 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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/72065796092592135-core_node5-n_0000000000
[junit4] 2> 1930859 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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:62892/solr/testScheduledTrigger_shard1_replica_n2/ shard1
[junit4] 2> 1930971 INFO (zkCallback-19514-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> 1930976 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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> 1931016 INFO (qtp440793563-30758) [n:127.0.0.1:62892_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=1286
[junit4] 2> 1931036 DEBUG (ScheduledTrigger-19524-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> 1931085 INFO (zkCallback-19514-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> 1931086 INFO (zkCallback-19514-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> 1931399 INFO (qtp246490717-30764) [n:127.0.0.1:62891_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=1669
[junit4] 2> 1931405 INFO (qtp246490717-30763) [n:127.0.0.1:62891_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=1674
[junit4] 2> 1931408 INFO (qtp246490717-30766) [n:127.0.0.1:62891_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> 1931495 INFO (zkCallback-19518-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> 1931495 INFO (zkCallback-19514-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> 1931495 INFO (zkCallback-19518-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> 1931495 INFO (zkCallback-19514-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> 1931498 INFO (qtp246490717-30766) [n:127.0.0.1:62891_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=2334
[junit4] 2> 1931498 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection:
testScheduledTrigger
[junit4] 2> 1931503 INFO (qtp246490717-30835) [n:127.0.0.1:62891_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&key=solr.core.testScheduledTrigger.shard1.replica_n4:INDEX.sizeInBytes}
status=0 QTime=0
[junit4] 2> 1931504 INFO (qtp246490717-30764) [n:127.0.0.1:62891_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=0
[junit4] 2> 1931505 INFO (qtp440793563-30761) [n:127.0.0.1:62892_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}
status=0 QTime=0
[junit4] 2> 1931506 INFO (qtp440793563-30762) [n:127.0.0.1:62892_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=0
[junit4] 2> 1931507 DEBUG (qtp246490717-30765) [n:127.0.0.1:62891_solr
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1931508 INFO (qtp246490717-30765) [n:127.0.0.1:62891_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=7
[junit4] 2> 1931509 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short
content, break even is size 23
[junit4] 2> 1931509 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding
port=0)
[junit4] 2> 1931509 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number
2 ...
[junit4] 2> 1931509 DEBUG (zkCallback-19518-thread-1) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
3
[junit4] 2> 1931509 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.e.j.s.Server jetty-9.4.27.v20200227; built:
2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm
11.0.6+10
[junit4] 2> 1931509 DEBUG
(OverseerAutoScalingTriggerThread-72065796092592136-127.0.0.1:62891_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 3
[junit4] 2> 1931511 DEBUG
(OverseerAutoScalingTriggerThread-72065796092592136-127.0.0.1:62891_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 1931512 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1931512 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1931512 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1931512 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7997f714{/solr,null,AVAILABLE}
[junit4] 2> 1931512 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.e.j.s.AbstractConnector Started ServerConnector@259d78a1{HTTP/1.1,
(http/1.1, h2c)}{127.0.0.1:62909}
[junit4] 2> 1931512 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.e.j.s.Server Started @1931604ms
[junit4] 2> 1931512 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=62909}
[junit4] 2> 1931512 DEBUG
(OverseerAutoScalingTriggerThread-72065796092592136-127.0.0.1:62891_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3,
lastZnodeVersion 3
[junit4] 2> 1931512 ERROR
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging
may be missing or incomplete.
[junit4] 2> 1931512 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1931512 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™
version 8.7.0
[junit4] 2> 1931512 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on
port null
[junit4] 2> 1931512 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr
[junit4] 2> 1931512 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-09-06T04:04:57.474869Z
[junit4] 2> 1931512 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1931519 INFO (zkConnectionManagerCallback-19562-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1931519 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1931520 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1931684 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1931685 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.e.j.u.s.S.config Trusting all certificates configured for
Client@61d8ccd5[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1931685 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm
configured for Client@61d8ccd5[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1931687 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.e.j.u.s.S.config Trusting all certificates configured for
Client@73cac89e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1931687 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm
configured for Client@73cac89e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1931688 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:62885/solr
[junit4] 2> 1931689 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1931692 INFO (zkConnectionManagerCallback-19572-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1931692 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1931695 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3]-SendThread(127.0.0.1:62885))
[ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for
session 0x1000775b08e000b.
[...truncated too long message...]
@76d9fb{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 1935521 INFO (jetty-closer-19583-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@1430ba8a{/solr,null,UNAVAILABLE}
[junit4] 2> 1935522 INFO (jetty-closer-19583-thread-1) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1935619 INFO (jetty-closer-19583-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@148214e3{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 1935619 INFO (jetty-closer-19583-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@7e3d83a0{/solr,null,UNAVAILABLE}
[junit4] 2> 1935619 INFO (jetty-closer-19583-thread-2) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1935620 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 1935621 WARN
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3]-SendThread(127.0.0.1:62885))
[ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for
session 0x1000775b08e0000.
[junit4] 2> => EndOfStreamException: Unable to read additional
data from server sessionid 0x1000775b08e0000, likely server has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable
to read additional data from server sessionid 0x1000775b08e0000, likely server
has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75)
~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:348)
~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1262)
[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> 1935838 WARN (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 7
/solr/collections/testScheduledTrigger/terms/shard1
[junit4] 2> 4 /solr/aliases.json
[junit4] 2> 4 /solr/clusterprops.json
[junit4] 2> 3
/solr/configs/testScheduledTrigger.AUTOCREATED/managed-schema
[junit4] 2> 3 /solr/packages.json
[junit4] 2> 3 /solr/security.json
[junit4] 2> 2 /solr/configs/testScheduledTrigger.AUTOCREATED
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 25
/solr/collections/testScheduledTrigger/state.json
[junit4] 2> 4 /solr/clusterstate.json
[junit4] 2> 4 /solr/autoscaling.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 25 /solr/overseer/queue
[junit4] 2> 14 /solr/live_nodes
[junit4] 2> 7 /solr/collections
[junit4] 2> 4 /solr/overseer/collection-queue-work
[junit4] 2> 2
/solr/autoscaling/events/sched_trigger_integration1
[junit4] 2>
[junit4] 2> 1935843 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:62885
[junit4] 2> 1935843 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:62885
[junit4] 2> 1935843 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 62885
[junit4] 2> 1935844 INFO
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[9C57F6DBAB1992B3])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testScheduledTrigger
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=ScheduledTriggerIntegrationTest -Dtests.method=testScheduledTrigger
-Dtests.seed=9C57F6DBAB1992B3 -Dtests.slow=true -Dtests.locale=vun
-Dtests.timezone=Asia/Riyadh -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 7.58s J1 |
ScheduledTriggerIntegrationTest.testScheduledTrigger <<<
[junit4] > Throwable #1: java.lang.AssertionError
[junit4] > at
__randomizedtesting.SeedInfo.seed([9C57F6DBAB1992B3:F4CBEA9F5E4C987]:0)
[junit4] > at
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest.testScheduledTrigger(ScheduledTriggerIntegrationTest.java:128)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] > at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at
java.base/java.lang.reflect.Method.invoke(Method.java:566)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:834)
[junit4] 2> NOTE: leaving temporary files on disk at:
/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_9C57F6DBAB1992B3-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene87),
sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=vun,
timezone=Asia/Riyadh
[junit4] 2> NOTE: Mac OS X 10.14.6 x86_64/AdoptOpenJDK 11.0.6
(64-bit)/cpus=6,threads=1,free=98551928,total=505151488
[junit4] 2> NOTE: All tests run in this JVM: [TestManagedSchemaAPI,
CloudMLTQParserTest, TestTolerantSearch, RequestHandlersTest,
CreateRoutedAliasTest, TestDynamicURP, ConnectionReuseTest,
DistributedQueueTest, TestReRankQParserPlugin, TestSimExecutePlanAction,
TestSolrConfigHandlerCloud, SolrCloudReportersTest,
ZkCollectionPropsCachingTest, TestSolrJacksonAnnotation, TestCustomSort,
SuggestComponentContextFilterQueryTest, TestLuceneIndexBackCompat,
TestSegmentSorting, TestSolrJ, NestedAtomicUpdateTest, CursorMarkTest,
RegexBytesRefFilterTest, RankFieldTest, TestInPlaceUpdatesStandalone,
TestMaxTokenLenTokenizer, DirectUpdateHandlerTest,
SignificantTermsQParserPluginTest, BasicFunctionalityTest,
MultiDestinationAuditLoggerTest, TestBackupRepositoryFactory,
TestIntervalFaceting, TestReplicationHandlerDiskOverFlow, SuggesterWFSTTest,
TestSolrQueryResponse, DocumentAnalysisRequestHandlerTest, StatsReloadRaceTest,
SystemLogListenerTest, TestFieldResource, TestSuggestSpellingConverter,
TestCloudSchemaless, UtilsToolTest, SolrMetricsIntegrationTest,
TestReloadAndDeleteDocs, DynamicMapsTest, QueryEqualityTest,
TestPKIAuthenticationPlugin, SecurityConfHandlerTest,
TestPHPSerializedResponseWriter, MissingSegmentRecoveryTest,
TestDocBasedVersionConstraints, TestContainerPlugin,
PeerSyncWithIndexFingerprintCachingTest, LeaderElectionIntegrationTest,
OverseerStatusTest, TestSolrCloudWithKerberosAlt,
RoutingToNodesWithPropertiesTest, ResponseHeaderTest, TestExportWriter,
TestOnReconnectListenerSupport, TestStressRecovery, URLClassifyProcessorTest,
RequestLoggingTest, TestCSVResponseWriter,
HdfsTlogReplayBufferedWhileIndexingTest, FullSolrCloudDistribCmdsTest,
TestCorePropertiesReload, TestLegacyNumericRangeQueryBuilder,
SolrTestCaseJ4Test, DeleteShardTest, ByteBuffersDirectoryFactoryTest,
TestUnifiedSolrHighlighterWithoutStoredId, SolrCmdDistributorTest,
TestNoOpRegenerator, ClusterStateMockUtilTest, NodeAddedTriggerTest,
TestTlogReplayVsRecovery, CollectionsAPISolrJTest, TestUninvertingReader,
ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, TestOrdValues,
UnloadDistributedZkTest, ChangedSchemaMergeTest, InfixSuggestersTest,
TaggerTest, TestHashQParserPlugin, TestSolrDeletionPolicy2,
TestUseDocValuesAsStored2, ResponseLogComponentTest, MetricUtilsTest,
TestTermsQParserPlugin, OverseerCollectionConfigSetProcessorTest,
PeerSyncReplicationTest, SystemCollectionCompatTest,
TestAuthenticationFramework, TestCloudPhrasesIdentificationComponent,
TestCloudPseudoReturnFields, TestCloudRecovery2, TestConfigSetsAPIExclusivity,
TestDeleteCollectionOnDownNodes, TestDistribDocBasedVersion,
TestLazySolrCluster, TestRandomFlRTGCloud,
TestTolerantUpdateProcessorRandomCloud, TestUtilizeNode,
TlogReplayBufferedWhileIndexingTest, ZkControllerTest, AssignTest,
AsyncCallRequestStatusResponseTest, CollectionReloadTest,
CollectionsAPIAsyncDistributedZkTest, SplitByPrefixTest,
TestLocalFSCloudBackupRestore, AutoAddReplicasIntegrationTest,
IndexSizeTriggerSizeEstimationTest, ScheduledTriggerIntegrationTest]
[junit4] Completed [589/919 (1!)] on J1 in 7.83s, 1 test, 1 failure <<<
FAILURES!
[...truncated 48815 lines...]
[repro] Jenkins log URL:
https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-MacOSX/1462/consoleText
[repro] Revision: de06e660d2a82e272519977f669e42664b782605
[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseSerialGC"
[repro] Repro line: ant test -Dtestcase=ScheduledTriggerIntegrationTest
-Dtests.method=testScheduledTrigger -Dtests.seed=9C57F6DBAB1992B3
-Dtests.slow=true -Dtests.locale=vun -Dtests.timezone=Asia/Riyadh
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
[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 3453 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5
-Dtests.class="*.ScheduledTriggerIntegrationTest" -Dtests.showOutput=onerror
"-Dargs=-XX:+UseCompressedOops -XX:+UseSerialGC" -Dtests.seed=9C57F6DBAB1992B3
-Dtests.slow=true -Dtests.locale=vun -Dtests.timezone=Asia/Riyadh
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
[...truncated 81 lines...]
[repro] Failures w/original seeds:
[repro] 0/5 failed:
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest
[repro] Exiting with code 0
[...truncated 91 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
