Build: https://builds.apache.org/job/Lucene-Solr-Tests-7.6/109/
1 tests failed.
FAILED:
org.apache.solr.cloud.LeaderElectionIntegrationTest.testSimpleSliceLeaderElection
Error Message:
Address already in use
Stack Trace:
java.net.BindException: Address already in use
at
__randomizedtesting.SeedInfo.seed([8E78B0B091ADBFC0:D04C7DFED2D22327]:0)
at sun.nio.ch.Net.bind0(Native Method)
at sun.nio.ch.Net.bind(Net.java:433)
at sun.nio.ch.Net.bind(Net.java:425)
at
sun.nio.ch.ServerSocketChannelImpl.bind(ServerSocketChannelImpl.java:223)
at sun.nio.ch.ServerSocketAdaptor.bind(ServerSocketAdaptor.java:74)
at
org.eclipse.jetty.server.ServerConnector.openAcceptChannel(ServerConnector.java:331)
at
org.eclipse.jetty.server.ServerConnector.open(ServerConnector.java:299)
at
org.eclipse.jetty.server.AbstractNetworkConnector.doStart(AbstractNetworkConnector.java:80)
at
org.eclipse.jetty.server.ServerConnector.doStart(ServerConnector.java:235)
at
org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:68)
at org.eclipse.jetty.server.Server.doStart(Server.java:398)
at
org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:68)
at
org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:396)
at
org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:369)
at
org.apache.solr.cloud.LeaderElectionIntegrationTest.testSimpleSliceLeaderElection(LeaderElectionIntegrationTest.java:108)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985)
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:944)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891)
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
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.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 14281 lines...]
[junit4] Suite: org.apache.solr.cloud.LeaderElectionIntegrationTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderElectionIntegrationTest_8E78B0B091ADBFC0-001/init-core-data-001
[junit4] 2> 1368575 WARN
(SUITE-LeaderElectionIntegrationTest-seed#[8E78B0B091ADBFC0]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=4 numCloses=4
[junit4] 2> 1368575 INFO
(SUITE-LeaderElectionIntegrationTest-seed#[8E78B0B091ADBFC0]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1368577 INFO
(SUITE-LeaderElectionIntegrationTest-seed#[8E78B0B091ADBFC0]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 1368578 INFO
(SUITE-LeaderElectionIntegrationTest-seed#[8E78B0B091ADBFC0]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1368581 INFO
(TEST-LeaderElectionIntegrationTest.testSimpleSliceLeaderElection-seed#[8E78B0B091ADBFC0])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testSimpleSliceLeaderElection
[junit4] 2> 1368581 INFO
(TEST-LeaderElectionIntegrationTest.testSimpleSliceLeaderElection-seed#[8E78B0B091ADBFC0])
[ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 6 servers in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderElectionIntegrationTest_8E78B0B091ADBFC0-001/tempDir-001
[junit4] 2> 1368581 INFO
(TEST-LeaderElectionIntegrationTest.testSimpleSliceLeaderElection-seed#[8E78B0B091ADBFC0])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1368582 INFO (Thread-2433) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1368582 INFO (Thread-2433) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1368584 ERROR (Thread-2433) [ ] o.a.z.s.ZooKeeperServer
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action
on ERROR or SHUTDOWN server state changes
[junit4] 2> 1368682 INFO
(TEST-LeaderElectionIntegrationTest.testSimpleSliceLeaderElection-seed#[8E78B0B091ADBFC0])
[ ] o.a.s.c.ZkTestServer start zk server on port:33839
[junit4] 2> 1368685 INFO (zkConnectionManagerCallback-3194-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1368691 INFO (jetty-launcher-3191-thread-1) [ ]
o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git:
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_191-b12
[junit4] 2> 1368693 INFO (jetty-launcher-3191-thread-2) [ ]
o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git:
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_191-b12
[junit4] 2> 1368693 INFO (jetty-launcher-3191-thread-3) [ ]
o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git:
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_191-b12
[junit4] 2> 1368694 INFO (jetty-launcher-3191-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1368694 INFO (jetty-launcher-3191-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1368694 INFO (jetty-launcher-3191-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1368694 INFO (jetty-launcher-3191-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@25b8cc44{/solr,null,AVAILABLE}
[junit4] 2> 1368695 INFO (jetty-launcher-3191-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@34e71a30{SSL,[ssl,
http/1.1]}{127.0.0.1:40771}
[junit4] 2> 1368695 INFO (jetty-launcher-3191-thread-1) [ ]
o.e.j.s.Server Started @1368755ms
[junit4] 2> 1368695 INFO (jetty-launcher-3191-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=40771}
[junit4] 2> 1368696 ERROR (jetty-launcher-3191-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1368696 INFO (jetty-launcher-3191-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1368696 INFO (jetty-launcher-3191-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.6.0
[junit4] 2> 1368696 INFO (jetty-launcher-3191-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1368696 INFO (jetty-launcher-3191-thread-4) [ ]
o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git:
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_191-b12
[junit4] 2> 1368696 INFO (jetty-launcher-3191-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1368696 INFO (jetty-launcher-3191-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-12-15T20:41:05.912Z
[junit4] 2> 1368698 INFO (jetty-launcher-3191-thread-5) [ ]
o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git:
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_191-b12
[junit4] 2> 1368699 INFO (jetty-launcher-3191-thread-4) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1368699 INFO (jetty-launcher-3191-thread-4) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1368699 INFO (jetty-launcher-3191-thread-6) [ ]
o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git:
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_191-b12
[junit4] 2> 1368699 INFO (jetty-launcher-3191-thread-4) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1368700 INFO (zkConnectionManagerCallback-3196-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1368701 INFO (jetty-launcher-3191-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1368701 INFO (jetty-launcher-3191-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@516dceff{/solr,null,AVAILABLE}
[junit4] 2> 1368702 INFO (jetty-launcher-3191-thread-4) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@645f9d96{SSL,[ssl,
http/1.1]}{127.0.0.1:45684}
[junit4] 2> 1368702 INFO (jetty-launcher-3191-thread-4) [ ]
o.e.j.s.Server Started @1368761ms
[junit4] 2> 1368702 INFO (jetty-launcher-3191-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=45684}
[junit4] 2> 1368702 ERROR (jetty-launcher-3191-thread-4) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1368702 INFO (jetty-launcher-3191-thread-4) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1368702 INFO (jetty-launcher-3191-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.6.0
[junit4] 2> 1368702 INFO (jetty-launcher-3191-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1368702 INFO (jetty-launcher-3191-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1368702 INFO (jetty-launcher-3191-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-12-15T20:41:05.918Z
[junit4] 2> 1368704 INFO (jetty-launcher-3191-thread-6) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1368704 INFO (jetty-launcher-3191-thread-6) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1368704 INFO (jetty-launcher-3191-thread-6) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1368704 INFO (jetty-launcher-3191-thread-6) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@77bfae5{/solr,null,AVAILABLE}
[junit4] 2> 1368704 INFO (jetty-launcher-3191-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1368704 INFO (jetty-launcher-3191-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1368704 INFO (jetty-launcher-3191-thread-2) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1368705 INFO (jetty-launcher-3191-thread-6) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@7ed529b6{SSL,[ssl,
http/1.1]}{127.0.0.1:32868}
[junit4] 2> 1368705 INFO (jetty-launcher-3191-thread-6) [ ]
o.e.j.s.Server Started @1368765ms
[junit4] 2> 1368705 INFO (jetty-launcher-3191-thread-6) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=32868}
[junit4] 2> 1368705 ERROR (jetty-launcher-3191-thread-6) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1368705 INFO (jetty-launcher-3191-thread-3) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1368705 INFO (jetty-launcher-3191-thread-6) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1368706 INFO (jetty-launcher-3191-thread-3) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1368706 INFO (jetty-launcher-3191-thread-6) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.6.0
[junit4] 2> 1368706 INFO (jetty-launcher-3191-thread-3) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1368706 INFO (jetty-launcher-3191-thread-6) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1368706 INFO (jetty-launcher-3191-thread-6) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1368706 INFO (jetty-launcher-3191-thread-6) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-12-15T20:41:05.922Z
[junit4] 2> 1368706 INFO (jetty-launcher-3191-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@16e0cfbc{/solr,null,AVAILABLE}
[junit4] 2> 1368707 INFO (jetty-launcher-3191-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@20182233{/solr,null,AVAILABLE}
[junit4] 2> 1368707 INFO (jetty-launcher-3191-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@7b6a80ce{SSL,[ssl,
http/1.1]}{127.0.0.1:41699}
[junit4] 2> 1368707 INFO (jetty-launcher-3191-thread-2) [ ]
o.e.j.s.Server Started @1368767ms
[junit4] 2> 1368707 INFO (jetty-launcher-3191-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=41699}
[junit4] 2> 1368708 ERROR (jetty-launcher-3191-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1368708 INFO (jetty-launcher-3191-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1368708 INFO (zkConnectionManagerCallback-3200-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1368708 INFO (jetty-launcher-3191-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.6.0
[junit4] 2> 1368708 INFO (jetty-launcher-3191-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1368708 INFO (jetty-launcher-3191-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1368708 INFO (jetty-launcher-3191-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-12-15T20:41:05.924Z
[junit4] 2> 1368708 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid
0x10168160eed0001, likely client has closed socket
[junit4] 2> 1368708 INFO (jetty-launcher-3191-thread-6) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1368709 INFO (jetty-launcher-3191-thread-3) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@4af00115{SSL,[ssl,
http/1.1]}{127.0.0.1:45185}
[junit4] 2> 1368709 INFO (jetty-launcher-3191-thread-3) [ ]
o.e.j.s.Server Started @1368768ms
[junit4] 2> 1368709 INFO (jetty-launcher-3191-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=45185}
[junit4] 2> 1368709 INFO (zkConnectionManagerCallback-3198-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1368709 ERROR (jetty-launcher-3191-thread-3) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1368709 INFO (jetty-launcher-3191-thread-3) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1368709 INFO (jetty-launcher-3191-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.6.0
[junit4] 2> 1368709 INFO (jetty-launcher-3191-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1368709 INFO (jetty-launcher-3191-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1368709 INFO (jetty-launcher-3191-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-12-15T20:41:05.925Z
[junit4] 2> 1368710 INFO (jetty-launcher-3191-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1368710 INFO (jetty-launcher-3191-thread-5) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1368710 INFO (jetty-launcher-3191-thread-5) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1368711 INFO (jetty-launcher-3191-thread-5) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1368711 INFO (zkConnectionManagerCallback-3204-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1368711 INFO (jetty-launcher-3191-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1368717 INFO (jetty-launcher-3191-thread-5) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@4c283f86{/solr,null,AVAILABLE}
[junit4] 2> 1368718 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid
0x10168160eed0005, likely client has closed socket
[junit4] 2> 1368718 INFO (jetty-launcher-3191-thread-5) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@6cae74ac{SSL,[ssl,
http/1.1]}{127.0.0.1:43788}
[junit4] 2> 1368718 INFO (jetty-launcher-3191-thread-5) [ ]
o.e.j.s.Server Started @1368778ms
[junit4] 2> 1368718 INFO (jetty-launcher-3191-thread-5) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=43788}
[junit4] 2> 1368718 ERROR (jetty-launcher-3191-thread-5) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1368718 INFO (jetty-launcher-3191-thread-5) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1368719 INFO (jetty-launcher-3191-thread-5) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.6.0
[junit4] 2> 1368719 INFO (jetty-launcher-3191-thread-5) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1368719 INFO (jetty-launcher-3191-thread-5) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1368719 INFO (jetty-launcher-3191-thread-5) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-12-15T20:41:05.935Z
[junit4] 2> 1368720 INFO (zkConnectionManagerCallback-3202-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1368720 INFO (jetty-launcher-3191-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1368738 INFO (zkConnectionManagerCallback-3206-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1368738 INFO (jetty-launcher-3191-thread-5) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1368794 INFO (jetty-launcher-3191-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33839/solr
[junit4] 2> 1368796 INFO (zkConnectionManagerCallback-3210-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1368798 INFO (zkConnectionManagerCallback-3212-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1368906 INFO (jetty-launcher-3191-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33839/solr
[junit4] 2> 1368914 INFO (zkConnectionManagerCallback-3218-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1368918 INFO (zkConnectionManagerCallback-3220-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1368936 INFO (jetty-launcher-3191-thread-2)
[n:127.0.0.1:41699_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:41699_solr
[junit4] 2> 1368937 INFO (jetty-launcher-3191-thread-1)
[n:127.0.0.1:40771_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:40771_solr
[junit4] 2> 1368938 INFO (jetty-launcher-3191-thread-2)
[n:127.0.0.1:41699_solr ] o.a.s.c.Overseer Overseer
(id=72453512963620872-127.0.0.1:41699_solr-n_0000000000) starting
[junit4] 2> 1368955 INFO (zkCallback-3211-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1368955 INFO (zkCallback-3219-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1368990 INFO (zkConnectionManagerCallback-3227-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1368991 INFO (jetty-launcher-3191-thread-2)
[n:127.0.0.1:41699_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1368992 INFO (jetty-launcher-3191-thread-2)
[n:127.0.0.1:41699_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:33839/solr ready
[junit4] 2> 1369002 INFO
(OverseerStateUpdate-72453512963620872-127.0.0.1:41699_solr-n_0000000000)
[n:127.0.0.1:41699_solr ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:41699_solr
[junit4] 2> 1369012 INFO (jetty-launcher-3191-thread-2)
[n:127.0.0.1:41699_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 1369012 INFO (jetty-launcher-3191-thread-2)
[n:127.0.0.1:41699_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:41699_solr
[junit4] 2> 1369033 INFO (zkConnectionManagerCallback-3232-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1369033 INFO (zkCallback-3219-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1369034 INFO (jetty-launcher-3191-thread-1)
[n:127.0.0.1:40771_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 1369035 INFO (jetty-launcher-3191-thread-1)
[n:127.0.0.1:40771_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:33839/solr ready
[junit4] 2> 1369042 INFO (zkCallback-3211-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1369042 INFO (jetty-launcher-3191-thread-1)
[n:127.0.0.1:40771_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1369071 INFO (jetty-launcher-3191-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33839/solr
[junit4] 2> 1369082 INFO (jetty-launcher-3191-thread-2)
[n:127.0.0.1:41699_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1369082 INFO (jetty-launcher-3191-thread-1)
[n:127.0.0.1:40771_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40771.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2d6197a1
[junit4] 2> 1369095 INFO (jetty-launcher-3191-thread-1)
[n:127.0.0.1:40771_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40771.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2d6197a1
[junit4] 2> 1369095 INFO (jetty-launcher-3191-thread-1)
[n:127.0.0.1:40771_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40771.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2d6197a1
[junit4] 2> 1369097 INFO (jetty-launcher-3191-thread-1)
[n:127.0.0.1:40771_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderElectionIntegrationTest_8E78B0B091ADBFC0-001/tempDir-001/node1/.
[junit4] 2> 1369103 INFO (zkCallback-3226-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1369122 INFO (jetty-launcher-3191-thread-2)
[n:127.0.0.1:41699_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41699.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2d6197a1
[junit4] 2> 1369126 INFO (zkConnectionManagerCallback-3238-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1369137 INFO (zkConnectionManagerCallback-3241-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1369138 INFO (jetty-launcher-3191-thread-2)
[n:127.0.0.1:41699_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41699.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2d6197a1
[junit4] 2> 1369138 INFO (jetty-launcher-3191-thread-2)
[n:127.0.0.1:41699_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41699.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2d6197a1
[junit4] 2> 1369142 INFO (jetty-launcher-3191-thread-2)
[n:127.0.0.1:41699_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderElectionIntegrationTest_8E78B0B091ADBFC0-001/tempDir-001/node2/.
[junit4] 2> 1369145 INFO (jetty-launcher-3191-thread-3)
[n:127.0.0.1:45185_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 1369150 INFO (jetty-launcher-3191-thread-3)
[n:127.0.0.1:45185_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 1369150 INFO (jetty-launcher-3191-thread-3)
[n:127.0.0.1:45185_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:45185_solr
[junit4] 2> 1369151 INFO (zkCallback-3219-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1369153 INFO (zkCallback-3226-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1369153 INFO (jetty-launcher-3191-thread-5) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33839/solr
[junit4] 2> 1369154 INFO (zkCallback-3240-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1369156 INFO (zkCallback-3231-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1369157 INFO (zkCallback-3211-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1369171 INFO (zkConnectionManagerCallback-3246-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1369173 INFO (zkConnectionManagerCallback-3248-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1369180 INFO (jetty-launcher-3191-thread-5)
[n:127.0.0.1:43788_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 1369185 INFO (jetty-launcher-3191-thread-5)
[n:127.0.0.1:43788_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 1369185 INFO (jetty-launcher-3191-thread-5)
[n:127.0.0.1:43788_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:43788_solr
[junit4] 2> 1369191 INFO (zkCallback-3219-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1369191 INFO (zkCallback-3226-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1369191 INFO (zkCallback-3231-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1369191 INFO (zkCallback-3240-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1369194 INFO (zkCallback-3247-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1369194 INFO (zkCallback-3211-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1369211 INFO (zkConnectionManagerCallback-3255-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1369211 INFO (zkConnectionManagerCallback-3260-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1369213 INFO (jetty-launcher-3191-thread-3)
[n:127.0.0.1:45185_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 1369213 INFO (jetty-launcher-3191-thread-5)
[n:127.0.0.1:43788_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 1369214 INFO (jetty-launcher-3191-thread-5)
[n:127.0.0.1:43788_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:33839/solr ready
[junit4] 2> 1369214 INFO (jetty-launcher-3191-thread-3)
[n:127.0.0.1:45185_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:33839/solr ready
[junit4] 2> 1369214 INFO (jetty-launcher-3191-thread-5)
[n:127.0.0.1:43788_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1369218 INFO (jetty-launcher-3191-thread-3)
[n:127.0.0.1:45185_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1369250 INFO (jetty-launcher-3191-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33839/solr
[junit4] 2> 1369252 INFO (zkConnectionManagerCallback-3266-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1369253 INFO (jetty-launcher-3191-thread-5)
[n:127.0.0.1:43788_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_43788.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2d6197a1
[junit4] 2> 1369254 INFO (jetty-launcher-3191-thread-3)
[n:127.0.0.1:45185_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45185.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2d6197a1
[junit4] 2> 1369255 INFO (zkConnectionManagerCallback-3268-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1369263 INFO (jetty-launcher-3191-thread-4)
[n:127.0.0.1:45684_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 1369268 INFO (jetty-launcher-3191-thread-4)
[n:127.0.0.1:45684_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 1369269 INFO (jetty-launcher-3191-thread-4)
[n:127.0.0.1:45684_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:45684_solr
[junit4] 2> 1369270 INFO (zkCallback-3231-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1369270 INFO (zkCallback-3226-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1369270 INFO (zkCallback-3247-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1369270 INFO (zkCallback-3211-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1369270 INFO (zkCallback-3219-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1369270 INFO (zkCallback-3240-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1369283 INFO (zkCallback-3254-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1369283 INFO (zkCallback-3259-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1369290 INFO (zkCallback-3267-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1369292 INFO (jetty-launcher-3191-thread-5)
[n:127.0.0.1:43788_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_43788.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2d6197a1
[junit4] 2> 1369292 INFO (jetty-launcher-3191-thread-5)
[n:127.0.0.1:43788_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_43788.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2d6197a1
[junit4] 2> 1369294 INFO (jetty-launcher-3191-thread-5)
[n:127.0.0.1:43788_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderElectionIntegrationTest_8E78B0B091ADBFC0-001/tempDir-001/node5/.
[junit4] 2> 1369298 INFO (jetty-launcher-3191-thread-3)
[n:127.0.0.1:45185_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45185.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2d6197a1
[junit4] 2> 1369298 INFO (jetty-launcher-3191-thread-3)
[n:127.0.0.1:45185_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45185.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2d6197a1
[junit4] 2> 1369300 INFO (jetty-launcher-3191-thread-3)
[n:127.0.0.1:45185_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderElectionIntegrationTest_8E78B0B091ADBFC0-001/tempDir-001/node3/.
[junit4] 2> 1369315 INFO (zkConnectionManagerCallback-3275-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1369316 INFO (jetty-launcher-3191-thread-4)
[n:127.0.0.1:45684_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (5)
[junit4] 2> 1369317 INFO (jetty-launcher-3191-thread-4)
[n:127.0.0.1:45684_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:33839/solr ready
[junit4] 2> 1369318 INFO (jetty-launcher-3191-thread-4)
[n:127.0.0.1:45684_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1369343 INFO (jetty-launcher-3191-thread-4)
[n:127.0.0.1:45684_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45684.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2d6197a1
[junit4] 2> 1369358 INFO (jetty-launcher-3191-thread-4)
[n:127.0.0.1:45684_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45684.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2d6197a1
[junit4] 2> 1369358 INFO (jetty-launcher-3191-thread-4)
[n:127.0.0.1:45684_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45684.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2d6197a1
[junit4] 2> 1369360 INFO (jetty-launcher-3191-thread-4)
[n:127.0.0.1:45684_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderElectionIntegrationTest_8E78B0B091ADBFC0-001/tempDir-001/node4/.
[junit4] 2> 1369369 INFO (jetty-launcher-3191-thread-6) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33839/solr
[junit4] 2> 1369373 INFO (zkConnectionManagerCallback-3280-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1369375 INFO (zkConnectionManagerCallback-3282-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1369385 INFO (jetty-launcher-3191-thread-6)
[n:127.0.0.1:32868_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (5)
[junit4] 2> 1369390 INFO (jetty-launcher-3191-thread-6)
[n:127.0.0.1:32868_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 1369390 INFO (jetty-launcher-3191-thread-6)
[n:127.0.0.1:32868_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:32868_solr
[junit4] 2> 1369392 INFO (zkCallback-3211-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1369393 INFO (zkCallback-3254-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1369393 INFO (zkCallback-3226-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1369393 INFO (zkCallback-3219-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1369394 INFO (zkCallback-3259-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1369394 INFO (zkCallback-3267-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1369397 INFO (zkCallback-3240-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1369397 INFO (zkCallback-3231-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1369399 INFO (zkCallback-3274-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1369399 INFO (zkCallback-3247-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1369407 INFO (zkCallback-3281-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1369422 INFO (zkConnectionManagerCallback-3289-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1369423 INFO (jetty-launcher-3191-thread-6)
[n:127.0.0.1:32868_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (6)
[junit4] 2> 1369424 INFO (jetty-launcher-3191-thread-6)
[n:127.0.0.1:32868_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:33839/solr ready
[junit4] 2> 1369425 INFO (jetty-launcher-3191-thread-6)
[n:127.0.0.1:32868_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 1369451 INFO (jetty-launcher-3191-thread-6)
[n:127.0.0.1:32868_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_32868.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2d6197a1
[junit4] 2> 1369465 INFO (jetty-launcher-3191-thread-6)
[n:127.0.0.1:32868_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_32868.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2d6197a1
[junit4] 2> 1369465 INFO (jetty-launcher-3191-thread-6)
[n:127.0.0.1:32868_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_32868.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2d6197a1
[junit4] 2> 1369467 INFO (jetty-launcher-3191-thread-6)
[n:127.0.0.1:32868_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderElectionIntegrationTest_8E78B0B091ADBFC0-001/tempDir-001/node6/.
[junit4] 2> 1369600 INFO (zkConnectionManagerCallback-3292-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1369604 INFO (zkConnectionManagerCallback-3297-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1369606 INFO
(TEST-LeaderElectionIntegrationTest.testSimpleSliceLeaderElection-seed#[8E78B0B091ADBFC0])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (6)
[junit4] 2> 1369607 INFO
(TEST-LeaderElectionIntegrationTest.testSimpleSliceLeaderElection-seed#[8E78B0B091ADBFC0])
[ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at
127.0.0.1:33839/solr ready
[junit4] 2> 1369636 INFO (qtp714491563-11576) [n:127.0.0.1:32868_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
collection.configName=conf&maxShardsPerNode=1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 1369641 INFO
(OverseerThreadFactory-5434-thread-1-processing-n:127.0.0.1:41699_solr)
[n:127.0.0.1:41699_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
collection1
[junit4] 2> 1369774 INFO (qtp714491563-11577) [n:127.0.0.1:32868_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1369793 INFO (qtp216512445-11542) [n:127.0.0.1:45684_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1369811 INFO (qtp1301274547-11580) [n:127.0.0.1:43788_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1369833 INFO (qtp1862625847-11585) [n:127.0.0.1:45185_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1369853 INFO (qtp1857899558-11535) [n:127.0.0.1:40771_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1369872 INFO (qtp226433129-11568) [n:127.0.0.1:41699_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1369877 INFO
(OverseerStateUpdate-72453512963620872-127.0.0.1:41699_solr-n_0000000000)
[n:127.0.0.1:41699_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"collection1_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:41699/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1369881 INFO
(OverseerStateUpdate-72453512963620872-127.0.0.1:41699_solr-n_0000000000)
[n:127.0.0.1:41699_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"collection1_shard2_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:40771/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1370094 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
x:collection1_shard2_replica_n2] o.a.s.h.a.CoreAdminOperation core create
command
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=collection1_shard2_replica_n2&action=CREATE&numShards=2&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1370094 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
x:collection1_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create
command
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=collection1_shard1_replica_n1&action=CREATE&numShards=2&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1370095 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
x:collection1_shard2_replica_n2] o.a.s.c.TransientSolrCoreCacheDefault
Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1371116 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.6.0
[junit4] 2> 1371116 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.6.0
[junit4] 2> 1371125 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2]
o.a.s.s.IndexSchema [collection1_shard2_replica_n2] Schema name=minimal
[junit4] 2> 1371126 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1]
o.a.s.s.IndexSchema [collection1_shard1_replica_n1] Schema name=minimal
[junit4] 2> 1371129 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1371129 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1371129 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2]
o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard2_replica_n2' using
configuration from collection collection1, trusted=true
[junit4] 2> 1371129 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n1' using
configuration from collection collection1, trusted=true
[junit4] 2> 1371130 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41699.solr.core.collection1.shard1.replica_n1' (registry
'solr.core.collection1.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2d6197a1
[junit4] 2> 1371130 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40771.solr.core.collection1.shard2.replica_n2' (registry
'solr.core.collection1.shard2.replica_n2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2d6197a1
[junit4] 2> 1371130 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1]
o.a.s.c.SolrCore [[collection1_shard1_replica_n1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderElectionIntegrationTest_8E78B0B091ADBFC0-001/tempDir-001/node2/collection1_shard1_replica_n1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderElectionIntegrationTest_8E78B0B091ADBFC0-001/tempDir-001/node2/./collection1_shard1_replica_n1/data/]
[junit4] 2> 1371130 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2]
o.a.s.c.SolrCore [[collection1_shard2_replica_n2] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderElectionIntegrationTest_8E78B0B091ADBFC0-001/tempDir-001/node1/collection1_shard2_replica_n2],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderElectionIntegrationTest_8E78B0B091ADBFC0-001/tempDir-001/node1/./collection1_shard2_replica_n2/data/]
[junit4] 2> 1371222 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1371226 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1371222 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1371227 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1371228 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1371228 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1371230 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@64778705[collection1_shard2_replica_n2] main]
[junit4] 2> 1371232 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1371232 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1371232 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 1371232 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1371233 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1371233 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1619951845060378624
[junit4] 2> 1371234 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@5f11d9a3[collection1_shard1_replica_n1] main]
[junit4] 2> 1371234 INFO
(searcherExecutor-5470-thread-1-processing-n:127.0.0.1:40771_solr
x:collection1_shard2_replica_n2 c:collection1 s:shard2 r:core_node4)
[n:127.0.0.1:40771_solr c:collection1 s:shard2 r:core_node4
x:collection1_shard2_replica_n2] o.a.s.c.SolrCore
[collection1_shard2_replica_n2] Registered new searcher
Searcher@64778705[collection1_shard2_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1371236 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 1371236 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1371237 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1371238 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1619951845065621504
[junit4] 2> 1371241 INFO
(searcherExecutor-5471-thread-1-processing-n:127.0.0.1:41699_solr
x:collection1_shard1_replica_n1 c:collection1 s:shard1 r:core_node3)
[n:127.0.0.1:41699_solr c:collection1 s:shard1 r:core_node3
x:collection1_shard1_replica_n1] o.a.s.c.SolrCore
[collection1_shard1_replica_n1] Registered new searcher
Searcher@5f11d9a3[collection1_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1371241 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/collection1/terms/shard2 to Terms{values={core_node4=0}, version=0}
[junit4] 2> 1371245 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/collection1/terms/shard1 to Terms{values={core_node3=0}, version=0}
[junit4] 2> 1371245 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1371246 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1371246 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 1371250 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1371250 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1371250 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 1371251 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:40771/solr/collection1_shard2_replica_n2/ shard2
[junit4] 2> 1371256 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:41699/solr/collection1_shard1_replica_n1/ shard1
[junit4] 2> 1371359 WARN (qtp226433129-11579) [n:127.0.0.1:41699_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1]
o.a.s.c.ZkController Skipping recovery according to sys prop
solrcloud.skip.autorecovery
[junit4] 2> 1371369 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=collection1_shard1_replica_n1&action=CREATE&numShards=2&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1275
[junit4] 2> 1371404 WARN (qtp1857899558-11536) [n:127.0.0.1:40771_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2]
o.a.s.c.ZkController Skipping recovery according to sys prop
solrcloud.skip.autorecovery
[junit4] 2> 1371407 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=collection1_shard2_replica_n2&action=CREATE&numShards=2&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1313
[junit4] 2> 1371410 INFO (qtp714491563-11576) [n:127.0.0.1:32868_solr
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
30 seconds. Check all shard replicas
[junit4] 2> 1371508 INFO (zkCallback-3211-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [6])
[junit4] 2> 1371508 INFO (zkCallback-3219-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [6])
[junit4] 2> 1371644 INFO
(OverseerCollectionConfigSetProcessor-72453512963620872-127.0.0.1:41699_solr-n_0000000000)
[n:127.0.0.1:41699_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 1372413 INFO (qtp714491563-11576) [n:127.0.0.1:32868_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={collection.configName=conf&maxShardsPerNode=1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2}
status=0 QTime=2777
[junit4] 2> 1372414 INFO (qtp714491563-11574) [n:127.0.0.1:32868_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with
params
action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 1372424 INFO (qtp714491563-11575) [n:127.0.0.1:32868_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1372427 INFO (qtp216512445-11545) [n:127.0.0.1:45684_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1372430 INFO (qtp1301274547-11560) [n:127.0.0.1:43788_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1372433 INFO (qtp1862625847-11583) [n:127.0.0.1:45185_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1372438 INFO (qtp1857899558-11533) [n:127.0.0.1:40771_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.collection1.shard2.replica_n2:INDEX.sizeInBytes}
status=0 QTime=1
[junit4] 2> 1372439 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1372443 INFO (qtp226433129-11562) [n:127.0.0.1:41699_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.collection1.shard1.replica_n1:INDEX.sizeInBytes}
status=0 QTime=0
[junit4] 2> 1372444 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1372445 INFO (qtp226433129-11562) [n:127.0.0.1:41699_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.collection1.shard1.replica_n1:INDEX.sizeInBytes}
status=0 QTime=0
[junit4] 2> 1372446 INFO
(OverseerThreadFactory-5434-thread-2-processing-n:127.0.0.1:41699_solr)
[n:127.0.0.1:41699_solr c:collection1 s:shard1 ] o.a.s.c.a.c.AddReplicaCmd
Node Identified 127.0.0.1:45185_solr for creating new replica of shard shard1
for collection collection1
[junit4] 2> 1372450 INFO
(OverseerStateUpdate-72453512963620872-127.0.0.1:41699_solr-n_0000000000)
[n:127.0.0.1:41699_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"addreplica",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"collection1_shard1_replica_n5",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:45185/solr";,
[junit4] 2> "node_name":"127.0.0.1:45185_solr",
[junit4] 2> "type":"NRT"}
[junit4] 2> 1372552 INFO (zkCallback-3219-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [6])
[junit4] 2> 1372552 INFO (zkCallback-3211-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [6])
[junit4] 2> 1372656 INFO (qtp1862625847-11555) [n:127.0.0.1:45185_solr
x:collection1_shard1_replica_n5] o.a.s.h.a.CoreAdminOperation core create
command
qt=/admin/cores&coreNodeName=core_node6&collection.configName=conf&name=collection1_shard1_replica_n5&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1372673 INFO (qtp1862625847-11555) [n:127.0.0.1:45185_solr
c:collection1 s:shard1 r:core_node6 x:collection1_shard1_replica_n5]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.6.0
[junit4] 2> 1372682 INFO (qtp1862625847-11555) [n:127.0.0.1:45185_solr
c:collection1 s:shard1 r:core_node6 x:collection1_shard1_replica_n5]
o.a.s.s.IndexSchema [collection1_shard1_replica_n5] Schema name=minimal
[junit4] 2> 1372685 INFO (qtp1862625847-11555) [n:127.0.0.1:45185_solr
c:collection1 s:shard1 r:core_node6 x:collection1_shard1_replica_n5]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1372685 INFO (qtp1862625847-11555) [n:127.0.0.1:45185_solr
c:collection1 s:shard1 r:core_node6 x:collection1_shard1_replica_n5]
o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n5' using
configuration from collection collection1, trusted=true
[junit4] 2> 1372686 INFO (qtp1862625847-11555) [n:127.0.0.1:45185_solr
c:collection1 s:shard1 r:core_node6 x:collection1_shard1_replica_n5]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45185.solr.core.collection1.shard1.replica_n5' (registry
'solr.core.collection1.shard1.replica_n5') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2d6197a1
[junit4] 2> 1372686 INFO (qtp1862625847-11555) [n:127.0.0.1:45185_solr
c:collection1 s:shard1 r:core_node6 x:collection1_shard1_replica_n5]
o.a.s.c.SolrCore [[collection1_shard1_replica_n5] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderElectionIntegrationTest_8E78B0B091ADBFC0-001/tempDir-001/node3/collection1_shard1_replica_n5],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderElectionIntegrationTest_8E78B0B091ADBFC0-001/tempDir-001/node3/./collection1_shard1_replica_n5/data/]
[junit4] 2> 1372762 INFO (zkCallback-3219-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [6])
[junit4] 2> 1372762 INFO (zkCallback-3211-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [6])
[junit4] 2> 1372762 INFO (qtp1862625847-11555) [n:127.0.0.1:45185_solr
c:collection1 s:shard1 r:core_node6 x:collection1_shard1_replica_n5]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1372763 INFO (qtp1862625847-11555) [n:127.0.0.1:45185_solr
c:collection1 s:shard1 r:core_node6 x:collection1_shard1_replica_n5]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1372765 INFO (qtp1862625847-11555) [n:127.0.0.1:45185_solr
c:collection1 s:shard1 r:core_node6 x:collection1_shard1_replica_n5]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1372765 INFO (qtp1862625847-11555) [n:127.0.0.1:45185_solr
c:collection1 s:shard1 r:core_node6 x:collection1_shard1_replica_n5]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1372767 INFO (qtp1862625847-11555) [n:127.0.0.1:45185_solr
c:collection1 s:shard1 r:core_node6 x:collection1_shard1_replica_n5]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@206fbf57[collection1_shard1_replica_n5] main]
[junit4] 2> 1372768 INFO (qtp1862625847-11555) [n:127.0.0.1:45185_solr
c:collection1 s:shard1 r:core_node6 x:collection1_shard1_replica_n5]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 1372769 INFO (qtp1862625847-11555) [n:127.0.0.1:45185_solr
c:collection1 s:shard1 r:core_node6 x:collection1_shard1_replica_n5]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1372770 INFO (qtp1862625847-11555) [n:127.0.0.1:45185_solr
c:collection1 s:shard1 r:core_node6 x:collection1_shard1_replica_n5]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1372770 INFO (qtp1862625847-11555) [n:127.0.0.1:45185_solr
c:collection1 s:shard1 r:core_node6 x:collection1_shard1_replica_n5]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1619951846672039936
[junit4] 2> 1372771 INFO
(searcherExecutor-5480-thread-1-processing-n:127.0.0.1:45185_solr
x:collection1_shard1_replica_n5 c:collection1 s:shard1 r:core_node6)
[n:127.0.0.1:45185_solr c:collection1 s:shard1 r:core_node6
x:collection1_shard1_replica_n5] o.a.s.c.SolrCore
[collection1_shard1_replica_n5] Registered new searcher
Searcher@206fbf57[collection1_shard1_replica_n5]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1372775 INFO (qtp1862625847-11555) [n:127.0.0.1:45185_solr
c:collection1 s:shard1 r:core_node6 x:collection1_shard1_replica_n5]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/collection1/terms/shard1 to Terms{values={core_node6=0,
core_node3=0}, version=1}
[junit4] 2> 1372778 WARN (qtp1862625847-11555) [n:127.0.0.1:45185_solr
c:collection1 s:shard1 r:core_node6 x:collection1_shard1_replica_n5]
o.a.s.c.ZkController Skipping recovery according to sys prop
solrcloud.skip.autorecovery
[junit4] 2> 1372781 INFO (qtp1862625847-11555) [n:127.0.0.1:45185_solr
c:collection1 s:shard1 r:core_node6 x:collection1_shard1_replica_n5]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node6&collection.configName=conf&name=collection1_shard1_replica_n5&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=124
[junit4] 2> 1372783 INFO (qtp714491563-11574) [n:127.0.0.1:32868_solr
c:collection1 ] o.a.s.s.HttpSolrCall [admin] webapp=null
path=/admin/collections
params={action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2}
status=0 QTime=369
[junit4] 2> 1372784 INFO (qtp714491563-11576) [n:127.0.0.1:32868_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with
params
action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 1372787 INFO
(OverseerCollectionConfigSetProcessor-72453512963620872-127.0.0.1:41699_solr-n_0000000000)
[n:127.0.0.1:41699_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 1372790 INFO (qtp714491563-11577) [n:127.0.0.1:32868_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1372791 INFO (qtp216512445-11542) [n:127.0.0.1:45684_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1372792 INFO (qtp1301274547-11580) [n:127.0.0.1:43788_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1372794 INFO (qtp1862625847-11585) [n:127.0.0.1:45185_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.collection1.shard1.replica_n5:INDEX.sizeInBytes}
status=0 QTime=1
[junit4] 2> 1372798 INFO (qtp1862625847-11555) [n:127.0.0.1:45185_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=1
[junit4] 2> 1372799 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.collection1.shard2.replica_n2:INDEX.sizeInBytes}
status=0 QTime=0
[junit4] 2> 1372801 INFO (qtp1857899558-11533) [n:127.0.0.1:40771_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1372802 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.collection1.shard1.replica_n1:INDEX.sizeInBytes}
status=0 QTime=0
[junit4] 2> 1372806 INFO (qtp226433129-11562) [n:127.0.0.1:41699_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1372810 INFO (qtp226433129-11562) [n:127.0.0.1:41699_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.collection1.shard1.replica_n1:INDEX.sizeInBytes}
status=0 QTime=0
[junit4] 2> 1372811 INFO
(OverseerThreadFactory-5434-thread-3-processing-n:127.0.0.1:41699_solr)
[n:127.0.0.1:41699_solr c:collection1 s:shard1 ] o.a.s.c.a.c.AddReplicaCmd
Node Identified 127.0.0.1:43788_solr for creating new replica of shard shard1
for collection collection1
[junit4] 2> 1372816 INFO
(OverseerStateUpdate-72453512963620872-127.0.0.1:41699_solr-n_0000000000)
[n:127.0.0.1:41699_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"addreplica",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"collection1_shard1_replica_n7",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:43788/solr";,
[junit4] 2> "node_name":"127.0.0.1:43788_solr",
[junit4] 2> "type":"NRT"}
[junit4] 2> 1372918 INFO (zkCallback-3219-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [6])
[junit4] 2> 1372918 INFO (zkCallback-3211-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [6])
[junit4] 2> 1372919 INFO (zkCallback-3240-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [6])
[junit4] 2> 1372919 INFO (zkCallback-3240-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [6])
[junit4] 2> 1373021 INFO (qtp1301274547-11580) [n:127.0.0.1:43788_solr
x:collection1_shard1_replica_n7] o.a.s.h.a.CoreAdminOperation core create
command
qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&name=collection1_shard1_replica_n7&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1373038 INFO (qtp1301274547-11580) [n:127.0.0.1:43788_solr
c:collection1 s:shard1 r:core_node8 x:collection1_shard1_replica_n7]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.6.0
[junit4] 2> 1373048 INFO (qtp1301274547-11580) [n:127.0.0.1:43788_solr
c:collection1 s:shard1 r:core_node8 x:collection1_shard1_replica_n7]
o.a.s.s.IndexSchema [collection1_shard1_replica_n7] Schema name=minimal
[junit4] 2> 1373051 INFO (qtp1301274547-11580) [n:127.0.0.1:43788_solr
c:collection1 s:shard1 r:core_node8 x:collection1_shard1_replica_n7]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1373052 INFO (qtp1301274547-11580) [n:127.0.0.1:43788_solr
c:collection1 s:shard1 r:core_node8 x:collection1_shard1_replica_n7]
o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n7' using
configuration from collection collection1, trusted=true
[junit4] 2> 1373052 INFO (qtp1301274547-11580) [n:127.0.0.1:43788_solr
c:collection1 s:shard1 r:core_node8 x:collection1_shard1_replica_n7]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_43788.solr.core.collection1.shard1.replica_n7' (registry
'solr.core.collection1.shard1.replica_n7') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2d6197a1
[junit4] 2> 1373053 INFO (qtp1301274547-11580) [n:127.0.0.1:43788_solr
c:collection1 s:shard1 r:core_node8 x:collection1_shard1_replica_n7]
o.a.s.c.SolrCore [[collection1_shard1_replica_n7] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderElectionIntegrationTest_8E78B0B091ADBFC0-001/tempDir-001/node5/collection1_shard1_replica_n7],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderElectionIntegrationTest_8E78B0B091ADBFC0-001/tempDir-001/node5/./collection1_shard1_replica_n7/data/]
[junit4] 2> 1373127 INFO (zkCallback-3240-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [6])
[junit4] 2> 1373127 INFO (zkCallback-3219-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [6])
[junit4] 2> 1373127 INFO (zkCallback-3240-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [6])
[junit4] 2> 1373127 INFO (zkCallback-3211-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [6])
[junit4] 2> 1373140 INFO (qtp1301274547-11580) [n:127.0.0.1:43788_solr
c:collection1 s:shard1 r:core_node8 x:collection1_shard1_replica_n7]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1373140 INFO (qtp1301274547-11580) [n:127.0.0.1:43788_solr
c:collection1 s:shard1 r:core_node8 x:collection1_shard1_replica_n7]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1373142 INFO (qtp1301274547-11580) [n:127.0.0.1:43788_solr
c:collection1 s:shard1 r:core_node8 x:collection1_shard1_replica_n7]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1373142 INFO (qtp1301274547-11580) [n:127.0.0.1:43788_solr
c:collection1 s:shard1 r:core_node8 x:collection1_shard1_replica_n7]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1373145 INFO (qtp1301274547-11580) [n:127.0.0.1:43788_solr
c:collection1 s:shard1 r:core_node8 x:collection1_shard1_replica_n7]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@54f339b2[collection1_shard1_replica_n7] main]
[junit4] 2> 1373146 INFO (qtp1301274547-11580) [n:127.0.0.1:43788_solr
c:collection1 s:shard1 r:core_node8 x:collection1_shard1_replica_n7]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 1373146 INFO (qtp1301274547-11580) [n:127.0.0.1:43788_solr
c:collection1 s:shard1 r:core_node8 x:collection1_shard1_replica_n7]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1373147 INFO (qtp1301274547-11580) [n:127.0.0.1:43788_solr
c:collection1 s:shard1 r:core_node8 x:collection1_shard1_replica_n7]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1373148 INFO (qtp1301274547-11580) [n:127.0.0.1:43788_solr
c:collection1 s:shard1 r:core_node8 x:collection1_shard1_replica_n7]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1619951847068401664
[junit4] 2> 1373150 INFO
(searcherExecutor-5485-thread-1-processing-n:127.0.0.1:43788_solr
x:collection1_shard1_replica_n7 c:collection1 s:shard1 r:core_node8)
[n:127.0.0.1:43788_solr c:collection1 s:shard1 r:core_node8
x:collection1_shard1_replica_n7] o.a.s.c.SolrCore
[collection1_shard1_replica_n7] Registered new searcher
Searcher@54f339b2[collection1_shard1_replica_n7]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1373154 INFO (qtp1301274547-11580) [n:127.0.0.1:43788_solr
c:collection1 s:shard1 r:core_node8 x:collection1_shard1_replica_n7]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/collection1/terms/shard1 to Terms{values={core_node6=0,
core_node3=0, core_node8=0}, version=2}
[junit4] 2> 1373157 WARN (qtp1301274547-11580) [n:127.0.0.1:43788_solr
c:collection1 s:shard1 r:core_node8 x:collection1_shard1_replica_n7]
o.a.s.c.ZkController Skipping recovery according to sys prop
solrcloud.skip.autorecovery
[junit4] 2> 1373161 INFO (qtp1301274547-11580) [n:127.0.0.1:43788_solr
c:collection1 s:shard1 r:core_node8 x:collection1_shard1_replica_n7]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&name=collection1_shard1_replica_n7&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=139
[junit4] 2> 1373164 INFO (qtp714491563-11576) [n:127.0.0.1:32868_solr
c:collection1 ] o.a.s.s.HttpSolrCall [admin] webapp=null
path=/admin/collections
params={action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2}
status=0 QTime=379
[junit4] 2> 1373165 INFO (qtp714491563-11574) [n:127.0.0.1:32868_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with
params
action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 1373168 INFO
(OverseerCollectionConfigSetProcessor-72453512963620872-127.0.0.1:41699_solr-n_0000000000)
[n:127.0.0.1:41699_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000004 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 1373172 INFO (qtp714491563-11575) [n:127.0.0.1:32868_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1373174 INFO (qtp216512445-11545) [n:127.0.0.1:45684_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1373176 INFO (qtp1301274547-11560) [n:127.0.0.1:43788_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.collection1.shard1.replica_n7:INDEX.sizeInBytes}
status=0 QTime=1
[junit4] 2> 1373177 INFO (qtp1301274547-11580) [n:127.0.0.1:43788_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=1
[junit4] 2> 1373180 INFO (qtp1862625847-11585) [n:127.0.0.1:45185_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.collection1.shard1.replica_n5:INDEX.sizeInBytes}
status=0 QTime=0
[junit4] 2> 1373182 INFO (qtp1862625847-11555) [n:127.0.0.1:45185_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1373183 INFO (qtp1857899558-11536) [n:127.0.0.1:40771_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.collection1.shard2.replica_n2:INDEX.sizeInBytes}
status=0 QTime=0
[junit4] 2> 1373185 INFO (qtp1857899558-11533) [n:127.0.0.1:40771_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1373186 INFO (qtp226433129-11579) [n:127.0.0.1:41699_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.collection1.shard1.replica_n1:INDEX.sizeInBytes}
status=0 QTime=0
[junit4] 2> 1373187 INFO (qtp226433129-11562) [n:127.0.0.1:41699_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 1373189 INFO (qtp226433129-11562) [n:127.0.0.1:41699_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.collection1.shard1.replica_n1:INDEX.sizeInBytes}
status=0 QTime=0
[junit4] 2> 1373190 INFO
(OverseerThreadFactory-5434-thread-4-processing-n:127.0.0.1:41699_solr)
[n:127.0.0.1:41699_solr c:collection1 s:shard1 ] o.a.s.c.a.c.AddReplicaCmd
Node Identified 127.0.0.1:45684_solr for creating new replica of shard shard1
for collection collection1
[junit4] 2> 1373194 INFO
(OverseerStateUpdate-72453512963620872-127.0.0.1:41699_solr-n_0000000000)
[n:127.0.0.1:41699_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"addreplica",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"collection1_shard1_replica_n9",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:45684/solr";,
[junit4] 2> "node_name":"127.0.0.1:45684_solr",
[junit4] 2> "type":"NRT"}
[junit4] 2> 1373297 INFO (zkCallback-3219-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cl
[...truncated too long message...]
eck:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/lucene/top-level-ivy-settings.xml
resolve:
jar-checksums:
[mkdir] Created dir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/solr/null1785114972
[copy] Copying 241 files to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/solr/null1785114972
[delete] Deleting directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.6/solr/null1785114972
check-working-copy:
[ivy:cachepath] :: resolving dependencies ::
org.eclipse.jgit#org.eclipse.jgit-caller;working
[ivy:cachepath] confs: [default]
[ivy:cachepath] found
org.eclipse.jgit#org.eclipse.jgit;4.6.0.201612231935-r in public
[ivy:cachepath] found com.jcraft#jsch;0.1.53 in public
[ivy:cachepath] found com.googlecode.javaewah#JavaEWAH;1.1.6 in public
[ivy:cachepath] found org.apache.httpcomponents#httpclient;4.3.6 in
public
[ivy:cachepath] found org.apache.httpcomponents#httpcore;4.3.3 in public
[ivy:cachepath] found commons-logging#commons-logging;1.1.3 in public
[ivy:cachepath] found commons-codec#commons-codec;1.6 in public
[ivy:cachepath] found org.slf4j#slf4j-api;1.7.2 in public
[ivy:cachepath] :: resolution report :: resolve 30ms :: artifacts dl 2ms
---------------------------------------------------------------------
| | modules || artifacts |
| conf | number| search|dwnlded|evicted|| number|dwnlded|
---------------------------------------------------------------------
| default | 8 | 0 | 0 | 0 || 8 | 0 |
---------------------------------------------------------------------
[wc-checker] Initializing working copy...
[wc-checker] SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
[wc-checker] SLF4J: Defaulting to no-operation (NOP) logger implementation
[wc-checker] SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for
further details.
[wc-checker] Checking working copy status...
-jenkins-base:
BUILD SUCCESSFUL
Total time: 97 minutes 59 seconds
Archiving artifacts
java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath$34.hasMatch(FilePath.java:2678)
at hudson.FilePath$34.invoke(FilePath.java:2557)
at hudson.FilePath$34.invoke(FilePath.java:2547)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:2918)
Also: hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene
at
hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1741)
at
hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:357)
at hudson.remoting.Channel.call(Channel.java:955)
at hudson.FilePath.act(FilePath.java:1036)
at hudson.FilePath.act(FilePath.java:1025)
at hudson.FilePath.validateAntFileMask(FilePath.java:2547)
at
hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
at
hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
at
hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at
hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
at
hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at
hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1819)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at
hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
Caused: hudson.FilePath$TunneledInterruptedException
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:2920)
at hudson.remoting.UserRequest.perform(UserRequest.java:212)
at hudson.remoting.UserRequest.perform(UserRequest.java:54)
at hudson.remoting.Request$2.run(Request.java:369)
at
hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:748)
Caused: java.lang.InterruptedException: java.lang.InterruptedException: no
matches found within 10000
at hudson.FilePath.act(FilePath.java:1038)
at hudson.FilePath.act(FilePath.java:1025)
at hudson.FilePath.validateAntFileMask(FilePath.java:2547)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
at
hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at
hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
at
hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at
hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1819)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
No artifacts found that match the file pattern
"**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error?
Recording test results
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
