Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/62/
Java: 64bit/jdk1.8.0_131 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
1 tests failed.
FAILED: org.apache.solr.cloud.MoveReplicaHDFSTest.test
Error Message:
127.0.0.1:41069_solr does not have expected number of cores expected:<0> but
was:<1>
Stack Trace:
java.lang.AssertionError: 127.0.0.1:41069_solr does not have expected number of
cores expected:<0> but was:<1>
at
__randomizedtesting.SeedInfo.seed([B8E062A738EE727F:30B45D7D96121F87]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at
org.apache.solr.cloud.MoveReplicaTest.checkNumOfCores(MoveReplicaTest.java:191)
at org.apache.solr.cloud.MoveReplicaTest.test(MoveReplicaTest.java:104)
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:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
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:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
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 12583 lines...]
[junit4] Suite: org.apache.solr.cloud.MoveReplicaHDFSTest
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaHDFSTest_B8E062A738EE727F-001/init-core-data-001
[junit4] 2> 2652808 WARN
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=12 numCloses=12
[junit4] 2> 2652808 INFO
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 2652809 INFO
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 2652809 INFO
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaHDFSTest_B8E062A738EE727F-001/tempDir-001
[junit4] 2> 2652810 INFO
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2652810 INFO (Thread-3254) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2652810 INFO (Thread-3254) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 2652816 ERROR (Thread-3254) [ ] 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> 2652910 INFO
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:36093
[junit4] 2> 2652915 INFO (jetty-launcher-5458-thread-2) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 2652915 INFO (jetty-launcher-5458-thread-1) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 2652917 INFO (jetty-launcher-5458-thread-3) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 2652921 INFO (jetty-launcher-5458-thread-4) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 2652942 INFO (jetty-launcher-5458-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6bb162d6{/solr,null,AVAILABLE}
[junit4] 2> 2652942 INFO (jetty-launcher-5458-thread-4) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@7620631b{SSL,[ssl,
http/1.1]}{127.0.0.1:41069}
[junit4] 2> 2652942 INFO (jetty-launcher-5458-thread-4) [ ]
o.e.j.s.Server Started @2653778ms
[junit4] 2> 2652942 INFO (jetty-launcher-5458-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=41069}
[junit4] 2> 2652943 ERROR (jetty-launcher-5458-thread-4) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2652943 INFO (jetty-launcher-5458-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.1.0
[junit4] 2> 2652943 INFO (jetty-launcher-5458-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2652943 INFO (jetty-launcher-5458-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 2652943 INFO (jetty-launcher-5458-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-07-12T10:49:51.758Z
[junit4] 2> 2652950 INFO (jetty-launcher-5458-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@61b28bad{/solr,null,AVAILABLE}
[junit4] 2> 2652951 INFO (jetty-launcher-5458-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@1daf67fd{SSL,[ssl,
http/1.1]}{127.0.0.1:39175}
[junit4] 2> 2652951 INFO (jetty-launcher-5458-thread-2) [ ]
o.e.j.s.Server Started @2653787ms
[junit4] 2> 2652951 INFO (jetty-launcher-5458-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=39175}
[junit4] 2> 2652951 ERROR (jetty-launcher-5458-thread-2) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2652951 INFO (jetty-launcher-5458-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.1.0
[junit4] 2> 2652951 INFO (jetty-launcher-5458-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2652951 INFO (jetty-launcher-5458-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 2652951 INFO (jetty-launcher-5458-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-07-12T10:49:51.766Z
[junit4] 2> 2652952 INFO (jetty-launcher-5458-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@4db561a1{/solr,null,AVAILABLE}
[junit4] 2> 2652955 INFO (jetty-launcher-5458-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@1716def8{SSL,[ssl,
http/1.1]}{127.0.0.1:36639}
[junit4] 2> 2652955 INFO (jetty-launcher-5458-thread-1) [ ]
o.e.j.s.Server Started @2653791ms
[junit4] 2> 2652955 INFO (jetty-launcher-5458-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=36639}
[junit4] 2> 2652956 ERROR (jetty-launcher-5458-thread-1) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2652956 INFO (jetty-launcher-5458-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.1.0
[junit4] 2> 2652956 INFO (jetty-launcher-5458-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2652956 INFO (jetty-launcher-5458-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 2652956 INFO (jetty-launcher-5458-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-07-12T10:49:51.771Z
[junit4] 2> 2652959 INFO (jetty-launcher-5458-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@46e6e5be{/solr,null,AVAILABLE}
[junit4] 2> 2652960 INFO (jetty-launcher-5458-thread-3) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@70aa12a8{SSL,[ssl,
http/1.1]}{127.0.0.1:41993}
[junit4] 2> 2652962 INFO (jetty-launcher-5458-thread-3) [ ]
o.e.j.s.Server Started @2653797ms
[junit4] 2> 2652962 INFO (jetty-launcher-5458-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=41993}
[junit4] 2> 2652962 INFO (jetty-launcher-5458-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2652962 ERROR (jetty-launcher-5458-thread-3) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2652962 INFO (jetty-launcher-5458-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.1.0
[junit4] 2> 2652962 INFO (jetty-launcher-5458-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2652962 INFO (jetty-launcher-5458-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 2652962 INFO (jetty-launcher-5458-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-07-12T10:49:51.777Z
[junit4] 2> 2652973 INFO (jetty-launcher-5458-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2652975 INFO (jetty-launcher-5458-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2652983 INFO (jetty-launcher-5458-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36093/solr
[junit4] 2> 2652986 INFO (jetty-launcher-5458-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2652993 INFO (jetty-launcher-5458-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36093/solr
[junit4] 2> 2652998 INFO (jetty-launcher-5458-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36093/solr
[junit4] 2> 2652999 INFO (jetty-launcher-5458-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36093/solr
[junit4] 2> 2653012 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15d366b5b0b000a, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 2653021 INFO (jetty-launcher-5458-thread-3)
[n:127.0.0.1:41993_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2653022 INFO (jetty-launcher-5458-thread-3)
[n:127.0.0.1:41993_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:41993_solr
[junit4] 2> 2653023 INFO (jetty-launcher-5458-thread-3)
[n:127.0.0.1:41993_solr ] o.a.s.c.Overseer Overseer
(id=98294601588867083-127.0.0.1:41993_solr-n_0000000000) starting
[junit4] 2> 2653025 INFO (jetty-launcher-5458-thread-4)
[n:127.0.0.1:41069_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2653026 INFO (jetty-launcher-5458-thread-4)
[n:127.0.0.1:41069_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:41069_solr
[junit4] 2> 2653046 INFO
(zkCallback-5481-thread-1-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 2653048 INFO (jetty-launcher-5458-thread-3)
[n:127.0.0.1:41993_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:41993_solr
[junit4] 2> 2653049 INFO
(OverseerStateUpdate-98294601588867083-127.0.0.1:41993_solr-n_0000000000)
[n:127.0.0.1:41993_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 2653055 INFO
(zkCallback-5482-thread-1-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 2653055 INFO
(zkCallback-5482-thread-2-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 2653061 INFO (jetty-launcher-5458-thread-1)
[n:127.0.0.1:36639_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 2653062 INFO (jetty-launcher-5458-thread-1)
[n:127.0.0.1:36639_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2653063 INFO (jetty-launcher-5458-thread-2)
[n:127.0.0.1:39175_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 2653063 INFO (jetty-launcher-5458-thread-1)
[n:127.0.0.1:36639_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:36639_solr
[junit4] 2> 2653064 INFO
(zkCallback-5481-thread-1-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2653064 INFO
(zkCallback-5482-thread-2-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2653064 INFO
(zkCallback-5473-thread-1-processing-n:127.0.0.1:36639_solr)
[n:127.0.0.1:36639_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2653079 INFO
(zkCallback-5472-thread-1-processing-n:127.0.0.1:39175_solr)
[n:127.0.0.1:39175_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2653080 INFO (jetty-launcher-5458-thread-2)
[n:127.0.0.1:39175_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2653081 INFO (jetty-launcher-5458-thread-2)
[n:127.0.0.1:39175_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:39175_solr
[junit4] 2> 2653081 INFO
(zkCallback-5481-thread-1-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2653081 INFO
(zkCallback-5472-thread-1-processing-n:127.0.0.1:39175_solr)
[n:127.0.0.1:39175_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2653082 INFO
(zkCallback-5473-thread-1-processing-n:127.0.0.1:36639_solr)
[n:127.0.0.1:36639_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2653091 INFO
(zkCallback-5482-thread-2-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2653120 INFO (jetty-launcher-5458-thread-3)
[n:127.0.0.1:41993_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41993.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3b5799f2
[junit4] 2> 2653123 INFO (jetty-launcher-5458-thread-3)
[n:127.0.0.1:41993_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41993.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3b5799f2
[junit4] 2> 2653123 INFO (jetty-launcher-5458-thread-3)
[n:127.0.0.1:41993_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41993.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3b5799f2
[junit4] 2> 2653124 INFO (jetty-launcher-5458-thread-3)
[n:127.0.0.1:41993_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaHDFSTest_B8E062A738EE727F-001/tempDir-001/node3/.
[junit4] 2> 2653127 INFO (jetty-launcher-5458-thread-4)
[n:127.0.0.1:41069_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41069.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3b5799f2
[junit4] 2> 2653130 INFO (jetty-launcher-5458-thread-4)
[n:127.0.0.1:41069_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41069.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3b5799f2
[junit4] 2> 2653130 INFO (jetty-launcher-5458-thread-4)
[n:127.0.0.1:41069_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41069.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3b5799f2
[junit4] 2> 2653131 INFO (jetty-launcher-5458-thread-4)
[n:127.0.0.1:41069_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaHDFSTest_B8E062A738EE727F-001/tempDir-001/node4/.
[junit4] 2> 2653199 INFO (jetty-launcher-5458-thread-2)
[n:127.0.0.1:39175_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39175.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3b5799f2
[junit4] 2> 2653203 INFO (jetty-launcher-5458-thread-2)
[n:127.0.0.1:39175_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39175.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3b5799f2
[junit4] 2> 2653203 INFO (jetty-launcher-5458-thread-2)
[n:127.0.0.1:39175_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39175.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3b5799f2
[junit4] 2> 2653204 INFO (jetty-launcher-5458-thread-2)
[n:127.0.0.1:39175_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaHDFSTest_B8E062A738EE727F-001/tempDir-001/node2/.
[junit4] 2> 2653219 INFO (jetty-launcher-5458-thread-1)
[n:127.0.0.1:36639_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36639.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3b5799f2
[junit4] 2> 2653223 INFO (jetty-launcher-5458-thread-1)
[n:127.0.0.1:36639_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36639.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3b5799f2
[junit4] 2> 2653223 INFO (jetty-launcher-5458-thread-1)
[n:127.0.0.1:36639_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36639.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3b5799f2
[junit4] 2> 2653224 INFO (jetty-launcher-5458-thread-1)
[n:127.0.0.1:36639_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaHDFSTest_B8E062A738EE727F-001/tempDir-001/node1/.
[junit4] 2> 2653252 INFO
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 2653253 INFO
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36093/solr ready
[junit4] 2> 2653619 WARN
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ]
o.a.h.u.NativeCodeLoader Unable to load native-hadoop library for your
platform... using builtin-java classes where applicable
[junit4] 1> Formatting using clusterid: testClusterID
[junit4] 2> 2654076 WARN
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ]
o.a.h.m.i.MetricsConfig Cannot locate configuration: tried
hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4] 2> 2654205 INFO
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ] o.m.log
Logging to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via
org.mortbay.log.Slf4jLog
[junit4] 2> 2654231 WARN
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ]
o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 2654280 INFO
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ] o.m.log
jetty-6.1.26
[junit4] 2> 2654320 INFO
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ] o.m.log
Extract
jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/hdfs
to ./temp/Jetty_localhost_localdomain_41335_hdfs____d0og0i/webapp
[junit4] 2> 2675052 WARN
(jetty-launcher-5458-thread-1-SendThread(127.0.0.1:36093))
[n:127.0.0.1:36639_solr ] o.a.z.ClientCnxn Client session timed out, have
not heard from server in 15155ms for sessionid 0x15d366b5b0b0007
[junit4] 2> 2675052 WARN
(jetty-launcher-5458-thread-4-SendThread(127.0.0.1:36093))
[n:127.0.0.1:41069_solr ] o.a.z.ClientCnxn Client session timed out, have
not heard from server in 15229ms for sessionid 0x15d366b5b0b000c
[junit4] 2> 2675052 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15d366b5b0b0007, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 2675052 WARN
(jetty-launcher-5458-thread-2-SendThread(127.0.0.1:36093))
[n:127.0.0.1:39175_solr ] o.a.z.ClientCnxn Client session timed out, have
not heard from server in 15180ms for sessionid 0x15d366b5b0b0008
[junit4] 2> 2675052 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15d366b5b0b000c, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 2675052 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15d366b5b0b0008, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 2675152 WARN (zkCallback-5488-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@2e34c19b name:
ZooKeeperConnection Watcher:127.0.0.1:36093/solr got event WatchedEvent
state:Disconnected type:None path:null path: null type: None
[junit4] 2> 2675152 WARN (zkCallback-5488-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has disconnected
[junit4] 2> 2675152 WARN
(zkCallback-5482-thread-2-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1928c2fc name:
ZooKeeperConnection Watcher:127.0.0.1:36093/solr got event WatchedEvent
state:Disconnected type:None path:null path: null type: None
[junit4] 2> 2675152 WARN
(zkCallback-5482-thread-2-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.ConnectionManager zkClient has
disconnected
[junit4] 2> 2675155 WARN
(zkCallback-5473-thread-2-processing-n:127.0.0.1:36639_solr)
[n:127.0.0.1:36639_solr ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@55e060e2 name:
ZooKeeperConnection Watcher:127.0.0.1:36093/solr got event WatchedEvent
state:Disconnected type:None path:null path: null type: None
[junit4] 2> 2675155 WARN
(zkCallback-5473-thread-2-processing-n:127.0.0.1:36639_solr)
[n:127.0.0.1:36639_solr ] o.a.s.c.c.ConnectionManager zkClient has
disconnected
[junit4] 2> 2675155 WARN
(zkCallback-5472-thread-2-processing-n:127.0.0.1:39175_solr)
[n:127.0.0.1:39175_solr ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@698fc2b9 name:
ZooKeeperConnection Watcher:127.0.0.1:36093/solr got event WatchedEvent
state:Disconnected type:None path:null path: null type: None
[junit4] 2> 2675159 WARN
(zkCallback-5472-thread-2-processing-n:127.0.0.1:39175_solr)
[n:127.0.0.1:39175_solr ] o.a.s.c.c.ConnectionManager zkClient has
disconnected
[junit4] 2> 2675220 INFO
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ] o.m.log
Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost.localdomain:41335
[junit4] 2> 2675909 WARN
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ]
o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 2675913 INFO
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ] o.m.log
jetty-6.1.26
[junit4] 2> 2675921 INFO
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ] o.m.log
Extract
jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_37263_datanode____.c67swe/webapp
[junit4] 2> 2681048 WARN
(jetty-launcher-5458-thread-1-SendThread(127.0.0.1:36093))
[n:127.0.0.1:36639_solr ] o.a.z.ClientCnxn Unable to reconnect to ZooKeeper
service, session 0x15d366b5b0b0007 has expired
[junit4] 2> 2681048 WARN
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker-SendThread(127.0.0.1:36093))
[ ] o.a.z.ClientCnxn Unable to reconnect to ZooKeeper service, session
0x15d366b5b0b000e has expired
[junit4] 2> 2681048 WARN (zkCallback-5488-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@2e34c19b name:
ZooKeeperConnection Watcher:127.0.0.1:36093/solr got event WatchedEvent
state:Expired type:None path:null path: null type: None
[junit4] 2> 2681048 WARN (zkCallback-5488-thread-1) [ ]
o.a.s.c.c.ConnectionManager Our previous ZooKeeper session was expired.
Attempting to reconnect to recover relationship with ZooKeeper...
[junit4] 2> 2681048 INFO
(zkCallback-5481-thread-1-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (1)
[junit4] 2> 2681048 WARN (zkCallback-5488-thread-1) [ ]
o.a.s.c.c.DefaultConnectionStrategy Connection expired - starting a new one...
[junit4] 2> 2681048 WARN
(jetty-launcher-5458-thread-4-SendThread(127.0.0.1:36093))
[n:127.0.0.1:41069_solr ] o.a.z.ClientCnxn Unable to reconnect to ZooKeeper
service, session 0x15d366b5b0b000c has expired
[junit4] 2> 2681048 WARN
(jetty-launcher-5458-thread-2-SendThread(127.0.0.1:36093))
[n:127.0.0.1:39175_solr ] o.a.z.ClientCnxn Unable to reconnect to ZooKeeper
service, session 0x15d366b5b0b0008 has expired
[junit4] 2> 2681049 WARN
(zkCallback-5473-thread-3-processing-n:127.0.0.1:36639_solr)
[n:127.0.0.1:36639_solr ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@55e060e2 name:
ZooKeeperConnection Watcher:127.0.0.1:36093/solr got event WatchedEvent
state:Expired type:None path:null path: null type: None
[junit4] 2> 2681049 WARN
(zkCallback-5473-thread-3-processing-n:127.0.0.1:36639_solr)
[n:127.0.0.1:36639_solr ] o.a.s.c.c.ConnectionManager Our previous ZooKeeper
session was expired. Attempting to reconnect to recover relationship with
ZooKeeper...
[junit4] 2> 2681049 WARN
(zkCallback-5482-thread-4-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1928c2fc name:
ZooKeeperConnection Watcher:127.0.0.1:36093/solr got event WatchedEvent
state:Expired type:None path:null path: null type: None
[junit4] 2> 2681049 WARN
(zkCallback-5482-thread-4-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.ConnectionManager Our previous ZooKeeper
session was expired. Attempting to reconnect to recover relationship with
ZooKeeper...
[junit4] 2> 2681049 INFO
(zkCallback-5473-thread-3-processing-n:127.0.0.1:36639_solr)
[n:127.0.0.1:36639_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 2681049 INFO
(zkCallback-5482-thread-4-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 2681051 WARN
(zkCallback-5472-thread-4-processing-n:127.0.0.1:39175_solr)
[n:127.0.0.1:39175_solr ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@698fc2b9 name:
ZooKeeperConnection Watcher:127.0.0.1:36093/solr got event WatchedEvent
state:Expired type:None path:null path: null type: None
[junit4] 2> 2681051 WARN
(zkCallback-5472-thread-4-processing-n:127.0.0.1:39175_solr)
[n:127.0.0.1:39175_solr ] o.a.s.c.c.ConnectionManager Our previous ZooKeeper
session was expired. Attempting to reconnect to recover relationship with
ZooKeeper...
[junit4] 2> 2681051 INFO
(zkCallback-5472-thread-4-processing-n:127.0.0.1:39175_solr)
[n:127.0.0.1:39175_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 2681049 WARN
(zkCallback-5473-thread-3-processing-n:127.0.0.1:36639_solr)
[n:127.0.0.1:36639_solr ] o.a.s.c.c.DefaultConnectionStrategy Connection
expired - starting a new one...
[junit4] 2> 2681049 WARN
(zkCallback-5482-thread-4-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.DefaultConnectionStrategy Connection
expired - starting a new one...
[junit4] 2> 2681051 WARN
(zkCallback-5472-thread-4-processing-n:127.0.0.1:39175_solr)
[n:127.0.0.1:39175_solr ] o.a.s.c.c.DefaultConnectionStrategy Connection
expired - starting a new one...
[junit4] 2> 2681052 INFO (zkCallback-5488-thread-1) [ ]
o.a.s.c.c.ConnectionManager Connection with ZooKeeper reestablished.
[junit4] 2> 2681053 INFO
(zkCallback-5473-thread-3-processing-n:127.0.0.1:36639_solr)
[n:127.0.0.1:36639_solr ] o.a.s.c.c.ConnectionManager Connection with
ZooKeeper reestablished.
[junit4] 2> 2681053 INFO
(zkCallback-5473-thread-3-processing-n:127.0.0.1:36639_solr)
[n:127.0.0.1:36639_solr ] o.a.s.c.ZkController ZooKeeper session
re-connected ... refreshing core states after session expiration.
[junit4] 2> 2681053 INFO
(zkCallback-5472-thread-4-processing-n:127.0.0.1:39175_solr)
[n:127.0.0.1:39175_solr ] o.a.s.c.c.ConnectionManager Connection with
ZooKeeper reestablished.
[junit4] 2> 2681053 INFO
(zkCallback-5482-thread-4-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.ConnectionManager Connection with
ZooKeeper reestablished.
[junit4] 2> 2681053 INFO
(zkCallback-5472-thread-4-processing-n:127.0.0.1:39175_solr)
[n:127.0.0.1:39175_solr ] o.a.s.c.ZkController ZooKeeper session
re-connected ... refreshing core states after session expiration.
[junit4] 2> 2681053 INFO
(zkCallback-5482-thread-4-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.ZkController ZooKeeper session
re-connected ... refreshing core states after session expiration.
[junit4] 2> 2681053 INFO
(zkCallback-5473-thread-3-processing-n:127.0.0.1:36639_solr)
[n:127.0.0.1:36639_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (1)
[junit4] 2> 2681054 INFO
(zkCallback-5472-thread-4-processing-n:127.0.0.1:39175_solr)
[n:127.0.0.1:39175_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (1)
[junit4] 2> 2681054 INFO
(zkCallback-5482-thread-4-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (1)
[junit4] 2> 2681055 INFO (zkCallback-5488-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (1)
[junit4] 2> 2681056 INFO (zkCallback-5488-thread-1) [ ]
o.a.s.c.c.DefaultConnectionStrategy Reconnected to ZooKeeper
[junit4] 2> 2681056 INFO (zkCallback-5488-thread-1) [ ]
o.a.s.c.c.ConnectionManager Connected:true
[junit4] 2> 2681057 INFO
(zkCallback-5473-thread-3-processing-n:127.0.0.1:36639_solr)
[n:127.0.0.1:36639_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:36639_solr
[junit4] 2> 2681057 INFO
(zkCallback-5482-thread-4-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:41069_solr
[junit4] 2> 2681058 INFO (zkCallback-5488-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2681058 INFO
(zkCallback-5481-thread-1-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 2681058 INFO
(zkCallback-5473-thread-3-processing-n:127.0.0.1:36639_solr)
[n:127.0.0.1:36639_solr ] o.a.s.c.c.DefaultConnectionStrategy Reconnected to
ZooKeeper
[junit4] 2> 2681058 INFO
(zkCallback-5473-thread-3-processing-n:127.0.0.1:36639_solr)
[n:127.0.0.1:36639_solr ] o.a.s.c.c.ConnectionManager Connected:true
[junit4] 2> 2681058 INFO
(zkCallback-5473-thread-5-processing-n:127.0.0.1:36639_solr)
[n:127.0.0.1:36639_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 2681058 INFO
(zkCallback-5482-thread-1-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (3)
[junit4] 2> 2681058 INFO (zkCallback-5488-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2681058 INFO
(zkCallback-5481-thread-1-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2681059 INFO
(zkCallback-5473-thread-5-processing-n:127.0.0.1:36639_solr)
[n:127.0.0.1:36639_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2681059 INFO
(zkCallback-5482-thread-4-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.DefaultConnectionStrategy Reconnected to
ZooKeeper
[junit4] 2> 2681059 INFO
(zkCallback-5482-thread-4-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.ConnectionManager Connected:true
[junit4] 2> 2681061 INFO
(zkCallback-5472-thread-4-processing-n:127.0.0.1:39175_solr)
[n:127.0.0.1:39175_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:39175_solr
[junit4] 2> 2681062 INFO (zkCallback-5488-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2681062 INFO
(zkCallback-5481-thread-1-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2681062 INFO
(zkCallback-5472-thread-4-processing-n:127.0.0.1:39175_solr)
[n:127.0.0.1:39175_solr ] o.a.s.c.c.DefaultConnectionStrategy Reconnected to
ZooKeeper
[junit4] 2> 2681062 INFO
(zkCallback-5473-thread-5-processing-n:127.0.0.1:36639_solr)
[n:127.0.0.1:36639_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2681063 INFO
(zkCallback-5472-thread-4-processing-n:127.0.0.1:39175_solr)
[n:127.0.0.1:39175_solr ] o.a.s.c.c.ConnectionManager Connected:true
[junit4] 2> 2681065 INFO
(zkCallback-5482-thread-4-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2681065 INFO
(zkCallback-5472-thread-4-processing-n:127.0.0.1:39175_solr)
[n:127.0.0.1:39175_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (4)
[junit4] 2> 2681414 INFO
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ] o.m.log
Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:37263
[junit4] 2> 2691752 WARN
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ]
o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 2691753 INFO
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ] o.m.log
jetty-6.1.26
[junit4] 2> 2691762 INFO
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ] o.m.log
Extract
jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_35851_datanode____ub6p09/webapp
[junit4] 2> 2692293 INFO
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ] o.m.log
Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:35851
[junit4] 2> 2692334 INFO (IPC Server handler 2 on 36851) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-c4bd3320-899e-49ae-b141-f1ad8b0aba2d node
DatanodeRegistration(127.0.0.1:45823,
datanodeUuid=0217ad3f-a37d-4718-910f-344de4bc1d9f, infoPort=41173,
infoSecurePort=0, ipcPort=43003,
storageInfo=lv=-56;cid=testClusterID;nsid=509704061;c=0), blocks: 0,
hasStaleStorage: true, processing time: 2 msecs
[junit4] 2> 2692334 INFO (IPC Server handler 2 on 36851) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-0a2dabe5-7816-4bcd-a521-deef750de2ae node
DatanodeRegistration(127.0.0.1:45823,
datanodeUuid=0217ad3f-a37d-4718-910f-344de4bc1d9f, infoPort=41173,
infoSecurePort=0, ipcPort=43003,
storageInfo=lv=-56;cid=testClusterID;nsid=509704061;c=0), blocks: 0,
hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 2692487 INFO (IPC Server handler 6 on 36851) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-392f245f-468b-46fa-9f48-48f7d3f0376f node
DatanodeRegistration(127.0.0.1:35555,
datanodeUuid=77616e28-c807-4b77-8488-79ae5d63718a, infoPort=45043,
infoSecurePort=0, ipcPort=43045,
storageInfo=lv=-56;cid=testClusterID;nsid=509704061;c=0), blocks: 0,
hasStaleStorage: true, processing time: 0 msecs
[junit4] 2> 2692487 INFO (IPC Server handler 6 on 36851) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-beed14e2-e8c7-41df-8e05-08740716e50a node
DatanodeRegistration(127.0.0.1:35555,
datanodeUuid=77616e28-c807-4b77-8488-79ae5d63718a, infoPort=45043,
infoSecurePort=0, ipcPort=43045,
storageInfo=lv=-56;cid=testClusterID;nsid=509704061;c=0), blocks: 0,
hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 2692968 INFO
(TEST-MoveReplicaHDFSTest.testDataDirAndUlogAreMaintained-seed#[B8E062A738EE727F])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testDataDirAndUlogAreMaintained
[junit4] 2> 2692983 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=conf1&name=movereplicatest_coll2&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2692985 INFO
(OverseerThreadFactory-7322-thread-1-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.CreateCollectionCmd Create collection
movereplicatest_coll2
[junit4] 2> 2692985 WARN
(OverseerThreadFactory-7322-thread-1-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.CreateCollectionCmd It is unusual to
create a collection (movereplicatest_coll2) without cores.
[junit4] 2> 2693087 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_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> 2693088 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=1&collection.configName=conf1&name=movereplicatest_coll2&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=&wt=javabin&version=2}
status=0 QTime=104
[junit4] 2> 2693089 INFO (qtp1955710585-26095) [n:127.0.0.1:41993_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with
params
node=127.0.0.1:41993_solr&dataDir=hdfs://localhost.localdomain:36851/dummyFolder/dataDir&action=ADDREPLICA&collection=movereplicatest_coll2&shard=shard1&type=NRT&wt=javabin&version=2&ulogDir=hdfs://localhost.localdomain:36851/dummyFolder2/ulogDir
and sendToOCPQueue=true
[junit4] 2> 2693091 INFO
(OverseerCollectionConfigSetProcessor-98294601588867083-127.0.0.1:41993_solr-n_0000000000)
[n:127.0.0.1:41993_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> 2693092 INFO
(OverseerThreadFactory-7322-thread-2-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.AddReplicaCmd Node Identified
127.0.0.1:41993_solr for creating new replica
[junit4] 2> 2693092 INFO
(OverseerStateUpdate-98294601588867083-127.0.0.1:41993_solr-n_0000000000)
[n:127.0.0.1:41993_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"addreplica",
[junit4] 2> "collection":"movereplicatest_coll2",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"movereplicatest_coll2_shard1_replica_n0",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:41993/solr";,
[junit4] 2> "node_name":"127.0.0.1:41993_solr",
[junit4] 2> "type":"NRT"}
[junit4] 2> 2693310 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node1&dataDir=hdfs://localhost.localdomain:36851/dummyFolder/dataDir&collection.configName=conf1&name=movereplicatest_coll2_shard1_replica_n0&action=CREATE&collection=movereplicatest_coll2&shard=shard1&wt=javabin&version=2&ulogDir=hdfs://localhost.localdomain:36851/dummyFolder2/ulogDir&replicaType=NRT
[junit4] 2> 2693311 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 2693325 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 7.1.0
[junit4] 2> 2693350 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.s.IndexSchema
[movereplicatest_coll2_shard1_replica_n0] Schema name=minimal
[junit4] 2> 2693353 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 2693353 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.c.CoreContainer Creating
SolrCore 'movereplicatest_coll2_shard1_replica_n0' using configuration from
collection movereplicatest_coll2, trusted=true
[junit4] 2> 2693354 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_41993.solr.core.movereplicatest_coll2.shard1.replica_n0'
(registry 'solr.core.movereplicatest_coll2.shard1.replica_n0') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@3b5799f2
[junit4] 2> 2693383 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.c.HdfsDirectoryFactory
solr.hdfs.home=hdfs://localhost.localdomain:36851/data
[junit4] 2> 2693384 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.c.HdfsDirectoryFactory Solr
Kerberos Authentication disabled
[junit4] 2> 2693384 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 2693384 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.c.SolrCore
[[movereplicatest_coll2_shard1_replica_n0] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaHDFSTest_B8E062A738EE727F-001/tempDir-001/node3/movereplicatest_coll2_shard1_replica_n0],
dataDir=[hdfs://localhost.localdomain:36851/dummyFolder/dataDir/]
[junit4] 2> 2693394 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.c.HdfsDirectoryFactory
creating directory factory for path
hdfs://localhost.localdomain:36851/dummyFolder/dataDir/snapshot_metadata
[junit4] 2> 2693426 INFO
(zkCallback-5481-thread-1-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll2/state.json] for collection
[movereplicatest_coll2] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2693426 INFO
(zkCallback-5481-thread-2-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll2/state.json] for collection
[movereplicatest_coll2] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2693497 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.c.HdfsDirectoryFactory
creating directory factory for path
hdfs://localhost.localdomain:36851/dummyFolder/dataDir
[junit4] 2> 2693536 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.c.HdfsDirectoryFactory
creating directory factory for path
hdfs://localhost.localdomain:36851/dummyFolder/dataDir/index
[junit4] 2> 2693797 INFO (IPC Server handler 5 on 36851) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:45823 is
added to blk_1073741825_1001{UCState=COMMITTED, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-392f245f-468b-46fa-9f48-48f7d3f0376f:NORMAL:127.0.0.1:35555|RBW],
ReplicaUC[[DISK]DS-0a2dabe5-7816-4bcd-a521-deef750de2ae:NORMAL:127.0.0.1:45823|RBW]]}
size 72
[junit4] 2> 2693798 INFO (IPC Server handler 4 on 36851) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:35555 is
added to blk_1073741825_1001 size 72
[junit4] 2> 2694241 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.u.UpdateHandler Using
UpdateLog implementation: org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 2694242 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2694242 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.u.HdfsUpdateLog Initializing
HdfsUpdateLog: tlogDfsReplication=3
[junit4] 2> 2694254 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 2694254 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 2694327 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.s.SolrIndexSearcher Opening
[Searcher@3fbcdf14[movereplicatest_coll2_shard1_replica_n0] main]
[junit4] 2> 2694328 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 2694328 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.r.ManagedResourceStorage
Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 2694331 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000
[junit4] 2> 2694332 INFO
(searcherExecutor-7331-thread-1-processing-n:127.0.0.1:41993_solr
x:movereplicatest_coll2_shard1_replica_n0 s:shard1 c:movereplicatest_coll2
r:core_node1) [n:127.0.0.1:41993_solr c:movereplicatest_coll2 s:shard1
r:core_node1 x:movereplicatest_coll2_shard1_replica_n0] o.a.s.c.SolrCore
[movereplicatest_coll2_shard1_replica_n0] Registered new searcher
Searcher@3fbcdf14[movereplicatest_coll2_shard1_replica_n0]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2694333 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1572713668959797248
[junit4] 2> 2694337 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.c.ShardLeaderElectionContext
Enough replicas found to continue.
[junit4] 2> 2694338 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.c.ShardLeaderElectionContext I
may be the new leader - try and sync
[junit4] 2> 2694338 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.c.SyncStrategy Sync replicas
to https://127.0.0.1:41993/solr/movereplicatest_coll2_shard1_replica_n0/
[junit4] 2> 2694338 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.c.SyncStrategy Sync Success -
now sync replicas to me
[junit4] 2> 2694338 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.c.SyncStrategy
https://127.0.0.1:41993/solr/movereplicatest_coll2_shard1_replica_n0/ has no
replicas
[junit4] 2> 2694338 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.c.ShardLeaderElectionContext
Found all replicas participating in election, clear LIR
[junit4] 2> 2694339 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.c.ShardLeaderElectionContext I
am the new leader:
https://127.0.0.1:41993/solr/movereplicatest_coll2_shard1_replica_n0/ shard1
[junit4] 2> 2694446 INFO
(zkCallback-5481-thread-1-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll2/state.json] for collection
[movereplicatest_coll2] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2694446 INFO
(zkCallback-5481-thread-2-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll2/state.json] for collection
[movereplicatest_coll2] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2694490 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.c.ZkController I am the
leader, no recovery necessary
[junit4] 2> 2694491 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n0] o.a.s.s.HttpSolrCall [admin]
webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node1&dataDir=hdfs://localhost.localdomain:36851/dummyFolder/dataDir&collection.configName=conf1&name=movereplicatest_coll2_shard1_replica_n0&action=CREATE&collection=movereplicatest_coll2&shard=shard1&wt=javabin&version=2&ulogDir=hdfs://localhost.localdomain:36851/dummyFolder2/ulogDir&replicaType=NRT}
status=0 QTime=1181
[junit4] 2> 2694492 INFO (qtp1955710585-26095) [n:127.0.0.1:41993_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={node=127.0.0.1:41993_solr&dataDir=hdfs://localhost.localdomain:36851/dummyFolder/dataDir&action=ADDREPLICA&collection=movereplicatest_coll2&shard=shard1&type=NRT&wt=javabin&version=2&ulogDir=hdfs://localhost.localdomain:36851/dummyFolder2/ulogDir}
status=0 QTime=1403
[junit4] 2> 2694592 INFO
(zkCallback-5481-thread-1-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll2/state.json] for collection
[movereplicatest_coll2] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2694592 INFO
(zkCallback-5481-thread-2-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll2/state.json] for collection
[movereplicatest_coll2] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2695093 INFO
(OverseerCollectionConfigSetProcessor-98294601588867083-127.0.0.1:41993_solr-n_0000000000)
[n:127.0.0.1:41993_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> 2695494 INFO (qtp1955710585-26100) [n:127.0.0.1:41993_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :movereplica with
params
replica=core_node1&action=MOVEREPLICA&collection=movereplicatest_coll2&targetNode=127.0.0.1:41069_solr&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2695495 INFO
(OverseerThreadFactory-7322-thread-3-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.MoveReplicaCmd Replica will be moved
core_node1:{"core":"movereplicatest_coll2_shard1_replica_n0","dataDir":"hdfs://localhost.localdomain:36851/dummyFolder/dataDir/","base_url":"https://127.0.0.1:41993/solr","node_name":"127.0.0.1:41993_solr","state":"active","type":"NRT","ulogDir":"hdfs://localhost.localdomain:36851/dummyFolder2/ulogDir/tlog","leader":"true"}
[junit4] 2> 2695496 INFO (qtp1955710585-26106) [n:127.0.0.1:41993_solr
] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.movereplicatest_coll2.shard1.replica_n0, tag=null
[junit4] 2> 2695501 INFO (qtp1955710585-26106) [n:127.0.0.1:41993_solr
] o.a.s.c.SolrCore [movereplicatest_coll2_shard1_replica_n0] CLOSING SolrCore
org.apache.solr.core.SolrCore@648cce13
[junit4] 2> 2695508 INFO (qtp1955710585-26106) [n:127.0.0.1:41993_solr
] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.movereplicatest_coll2.shard1.replica_n0, tag=1686949395
[junit4] 2> 2695508 INFO (qtp1955710585-26106) [n:127.0.0.1:41993_solr
] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.movereplicatest_coll2.shard1.leader, tag=1686949395
[junit4] 2> 2695508 INFO (qtp1955710585-26106) [n:127.0.0.1:41993_solr
] o.a.s.s.h.HdfsDirectory Closing hdfs directory
hdfs://localhost.localdomain:36851/dummyFolder/dataDir/snapshot_metadata
[junit4] 2> 2695508 INFO (qtp1955710585-26106) [n:127.0.0.1:41993_solr
] o.a.s.s.h.HdfsDirectory Closing hdfs directory
hdfs://localhost.localdomain:36851/dummyFolder/dataDir/index
[junit4] 2> 2695508 INFO (qtp1955710585-26106) [n:127.0.0.1:41993_solr
] o.a.s.s.h.HdfsDirectory Closing hdfs directory
hdfs://localhost.localdomain:36851/dummyFolder/dataDir
[junit4] 2> 2695514 INFO (qtp1955710585-26106) [n:127.0.0.1:41993_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={deleteInstanceDir=true&core=movereplicatest_coll2_shard1_replica_n0&qt=/admin/cores&deleteDataDir=false&action=UNLOAD&wt=javabin&version=2&deleteIndex=false}
status=0 QTime=17
[junit4] 2> 2695616 INFO
(zkCallback-5481-thread-1-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll2/state.json] for collection
[movereplicatest_coll2] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2695616 INFO
(zkCallback-5481-thread-2-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll2/state.json] for collection
[movereplicatest_coll2] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2695616 INFO
(zkCallback-5481-thread-3-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll2/state.json] for collection
[movereplicatest_coll2] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2695715 INFO
(OverseerThreadFactory-7322-thread-3-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.AddReplicaCmd Node Identified
127.0.0.1:41069_solr for creating new replica
[junit4] 2> 2695716 INFO
(OverseerStateUpdate-98294601588867083-127.0.0.1:41993_solr-n_0000000000)
[n:127.0.0.1:41993_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"addreplica",
[junit4] 2> "collection":"movereplicatest_coll2",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"movereplicatest_coll2_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:41069/solr";,
[junit4] 2> "node_name":"127.0.0.1:41069_solr",
[junit4] 2> "type":"NRT"}
[junit4] 2> 2695935 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node1&dataDir=hdfs://localhost.localdomain:36851/dummyFolder/dataDir/&collection.configName=conf1&name=movereplicatest_coll2_shard1_replica_n1&action=CREATE&collection=movereplicatest_coll2&shard=shard1&wt=javabin&version=2&ulogDir=hdfs://localhost.localdomain:36851/dummyFolder2/ulogDir/&replicaType=NRT
[junit4] 2> 2695953 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 7.1.0
[junit4] 2> 2695958 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.s.IndexSchema
[movereplicatest_coll2_shard1_replica_n1] Schema name=minimal
[junit4] 2> 2695960 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 2695960 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.c.CoreContainer Creating
SolrCore 'movereplicatest_coll2_shard1_replica_n1' using configuration from
collection movereplicatest_coll2, trusted=true
[junit4] 2> 2695960 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_41069.solr.core.movereplicatest_coll2.shard1.replica_n1'
(registry 'solr.core.movereplicatest_coll2.shard1.replica_n1') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@3b5799f2
[junit4] 2> 2695960 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.c.HdfsDirectoryFactory
solr.hdfs.home=hdfs://localhost.localdomain:36851/data
[junit4] 2> 2695960 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.c.HdfsDirectoryFactory Solr
Kerberos Authentication disabled
[junit4] 2> 2695960 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 2695961 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.c.SolrCore
[[movereplicatest_coll2_shard1_replica_n1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaHDFSTest_B8E062A738EE727F-001/tempDir-001/node4/movereplicatest_coll2_shard1_replica_n1],
dataDir=[hdfs://localhost.localdomain:36851/dummyFolder/dataDir/]
[junit4] 2> 2695961 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.c.HdfsDirectoryFactory
creating directory factory for path
hdfs://localhost.localdomain:36851/dummyFolder/dataDir/snapshot_metadata
[junit4] 2> 2695971 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.c.HdfsDirectoryFactory
creating directory factory for path
hdfs://localhost.localdomain:36851/dummyFolder/dataDir
[junit4] 2> 2696041 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.u.UpdateHandler Using
UpdateLog implementation: org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 2696041 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2696041 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.u.HdfsUpdateLog Initializing
HdfsUpdateLog: tlogDfsReplication=3
[junit4] 2> 2696044 INFO
(zkCallback-5482-thread-4-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll2/state.json] for collection
[movereplicatest_coll2] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2696044 INFO
(zkCallback-5482-thread-1-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll2/state.json] for collection
[movereplicatest_coll2] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2696052 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 2696052 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 2696054 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.c.HdfsDirectoryFactory
creating directory factory for path
hdfs://localhost.localdomain:36851/dummyFolder/dataDir/index
[junit4] 2> 2696077 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@366978e5[movereplicatest_coll2_shard1_replica_n1] main]
[junit4] 2> 2696078 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 2696078 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.r.ManagedResourceStorage
Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 2696079 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000
[junit4] 2> 2696080 INFO
(searcherExecutor-7336-thread-1-processing-n:127.0.0.1:41069_solr
x:movereplicatest_coll2_shard1_replica_n1 s:shard1 c:movereplicatest_coll2
r:core_node1) [n:127.0.0.1:41069_solr c:movereplicatest_coll2 s:shard1
r:core_node1 x:movereplicatest_coll2_shard1_replica_n1] o.a.s.c.SolrCore
[movereplicatest_coll2_shard1_replica_n1] Registered new searcher
Searcher@366978e5[movereplicatest_coll2_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2696080 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1572713670791659520
[junit4] 2> 2696083 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext
Enough replicas found to continue.
[junit4] 2> 2696083 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I
may be the new leader - try and sync
[junit4] 2> 2696083 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas
to https://127.0.0.1:41069/solr/movereplicatest_coll2_shard1_replica_n1/
[junit4] 2> 2696083 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success -
now sync replicas to me
[junit4] 2> 2696083 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.c.SyncStrategy
https://127.0.0.1:41069/solr/movereplicatest_coll2_shard1_replica_n1/ has no
replicas
[junit4] 2> 2696083 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext
Found all replicas participating in election, clear LIR
[junit4] 2> 2696088 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I
am the new leader:
https://127.0.0.1:41069/solr/movereplicatest_coll2_shard1_replica_n1/ shard1
[junit4] 2> 2696190 INFO
(zkCallback-5482-thread-4-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll2/state.json] for collection
[movereplicatest_coll2] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2696190 INFO
(zkCallback-5482-thread-1-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll2/state.json] for collection
[movereplicatest_coll2] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2696239 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.c.ZkController I am the
leader, no recovery necessary
[junit4] 2> 2696240 INFO (qtp711907847-26093) [n:127.0.0.1:41069_solr
c:movereplicatest_coll2 s:shard1 r:core_node1
x:movereplicatest_coll2_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin]
webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node1&dataDir=hdfs://localhost.localdomain:36851/dummyFolder/dataDir/&collection.configName=conf1&name=movereplicatest_coll2_shard1_replica_n1&action=CREATE&collection=movereplicatest_coll2&shard=shard1&wt=javabin&version=2&ulogDir=hdfs://localhost.localdomain:36851/dummyFolder2/ulogDir/&replicaType=NRT}
status=0 QTime=305
[junit4] 2> 2696242 INFO (qtp1955710585-26100) [n:127.0.0.1:41993_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replica=core_node1&action=MOVEREPLICA&collection=movereplicatest_coll2&targetNode=127.0.0.1:41069_solr&wt=javabin&version=2}
status=0 QTime=747
[junit4] 2> 2696341 INFO
(zkCallback-5482-thread-4-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll2/state.json] for collection
[movereplicatest_coll2] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2696341 INFO
(zkCallback-5482-thread-1-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll2/state.json] for collection
[movereplicatest_coll2] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2697244 INFO
(TEST-MoveReplicaHDFSTest.testDataDirAndUlogAreMaintained-seed#[B8E062A738EE727F])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testDataDirAndUlogAreMaintained
[junit4] 2> 2697295 INFO
(TEST-MoveReplicaHDFSTest.test-seed#[B8E062A738EE727F]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 2697299 INFO
(TEST-MoveReplicaHDFSTest.test-seed#[B8E062A738EE727F]) [ ]
o.a.s.c.MoveReplicaTest total_jettys: 4
[junit4] 2> 2697300 INFO (qtp1955710585-26096) [n:127.0.0.1:41993_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=2&collection.configName=conf1&maxShardsPerNode=2&name=movereplicatest_coll&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2697301 INFO
(OverseerThreadFactory-7322-thread-4-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.CreateCollectionCmd Create collection
movereplicatest_coll
[junit4] 2> 2697301 INFO
(OverseerCollectionConfigSetProcessor-98294601588867083-127.0.0.1:41993_solr-n_0000000000)
[n:127.0.0.1:41993_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> 2697504 INFO
(OverseerStateUpdate-98294601588867083-127.0.0.1:41993_solr-n_0000000000)
[n:127.0.0.1:41993_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"movereplicatest_coll",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"movereplicatest_coll_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:41069/solr";,
[junit4] 2> "type":"NRT"}
[junit4] 2> 2697505 INFO
(OverseerStateUpdate-98294601588867083-127.0.0.1:41993_solr-n_0000000000)
[n:127.0.0.1:41993_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"movereplicatest_coll",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"movereplicatest_coll_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:41993/solr";,
[junit4] 2> "type":"NRT"}
[junit4] 2> 2697506 INFO
(OverseerStateUpdate-98294601588867083-127.0.0.1:41993_solr-n_0000000000)
[n:127.0.0.1:41993_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"movereplicatest_coll",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"movereplicatest_coll_shard2_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:36639/solr";,
[junit4] 2> "type":"NRT"}
[junit4] 2> 2697506 INFO
(OverseerStateUpdate-98294601588867083-127.0.0.1:41993_solr-n_0000000000)
[n:127.0.0.1:41993_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"movereplicatest_coll",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"movereplicatest_coll_shard2_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:39175/solr";,
[junit4] 2> "type":"NRT"}
[junit4] 2> 2697708 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf1&newCollection=true&name=movereplicatest_coll_shard1_replica_n2&action=CREATE&numShards=2&collection=movereplicatest_coll&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2697712 INFO (qtp711907847-26086) [n:127.0.0.1:41069_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node1&collection.configName=conf1&newCollection=true&name=movereplicatest_coll_shard1_replica_n1&action=CREATE&numShards=2&collection=movereplicatest_coll&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2697743 INFO (qtp1500762002-26111) [n:127.0.0.1:39175_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf1&newCollection=true&name=movereplicatest_coll_shard2_replica_n2&action=CREATE&numShards=2&collection=movereplicatest_coll&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2697750 INFO (qtp2074792838-26082) [n:127.0.0.1:36639_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf1&newCollection=true&name=movereplicatest_coll_shard2_replica_n1&action=CREATE&numShards=2&collection=movereplicatest_coll&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2697857 INFO
(zkCallback-5482-thread-1-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll/state.json] for collection
[movereplicatest_coll] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2697857 INFO
(zkCallback-5472-thread-4-processing-n:127.0.0.1:39175_solr)
[n:127.0.0.1:39175_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll/state.json] for collection
[movereplicatest_coll] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2697857 INFO
(zkCallback-5482-thread-4-processing-n:127.0.0.1:41069_solr)
[n:127.0.0.1:41069_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll/state.json] for collection
[movereplicatest_coll] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2697857 INFO
(zkCallback-5473-thread-3-processing-n:127.0.0.1:36639_solr)
[n:127.0.0.1:36639_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll/state.json] for collection
[movereplicatest_coll] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2697857 INFO
(zkCallback-5472-thread-5-processing-n:127.0.0.1:39175_solr)
[n:127.0.0.1:39175_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll/state.json] for collection
[movereplicatest_coll] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2697857 INFO
(zkCallback-5481-thread-3-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll/state.json] for collection
[movereplicatest_coll] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2697857 INFO
(zkCallback-5473-thread-5-processing-n:127.0.0.1:36639_solr)
[n:127.0.0.1:36639_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll/state.json] for collection
[movereplicatest_coll] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2697857 INFO
(zkCallback-5481-thread-1-processing-n:127.0.0.1:41993_solr)
[n:127.0.0.1:41993_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/movereplicatest_coll/state.json] for collection
[movereplicatest_coll] has occurred - updating... (live nodes size: [4])
[junit4] 2> 2698714 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll s:shard1 r:core_node2
x:movereplicatest_coll_shard1_replica_n2] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 7.1.0
[junit4] 2> 2698718 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll s:shard1 r:core_node2
x:movereplicatest_coll_shard1_replica_n2] o.a.s.s.IndexSchema
[movereplicatest_coll_shard1_replica_n2] Schema name=minimal
[junit4] 2> 2698719 INFO (qtp711907847-26086) [n:127.0.0.1:41069_solr
c:movereplicatest_coll s:shard1 r:core_node1
x:movereplicatest_coll_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 7.1.0
[junit4] 2> 2698721 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll s:shard1 r:core_node2
x:movereplicatest_coll_shard1_replica_n2] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 2698721 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll s:shard1 r:core_node2
x:movereplicatest_coll_shard1_replica_n2] o.a.s.c.CoreContainer Creating
SolrCore 'movereplicatest_coll_shard1_replica_n2' using configuration from
collection movereplicatest_coll, trusted=true
[junit4] 2> 2698722 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll s:shard1 r:core_node2
x:movereplicatest_coll_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_41993.solr.core.movereplicatest_coll.shard1.replica_n2'
(registry 'solr.core.movereplicatest_coll.shard1.replica_n2') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@3b5799f2
[junit4] 2> 2698722 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll s:shard1 r:core_node2
x:movereplicatest_coll_shard1_replica_n2] o.a.s.c.HdfsDirectoryFactory
solr.hdfs.home=hdfs://localhost.localdomain:36851/data
[junit4] 2> 2698723 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll s:shard1 r:core_node2
x:movereplicatest_coll_shard1_replica_n2] o.a.s.c.HdfsDirectoryFactory Solr
Kerberos Authentication disabled
[junit4] 2> 2698723 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll s:shard1 r:core_node2
x:movereplicatest_coll_shard1_replica_n2] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 2698723 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll s:shard1 r:core_node2
x:movereplicatest_coll_shard1_replica_n2] o.a.s.c.SolrCore
[[movereplicatest_coll_shard1_replica_n2] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaHDFSTest_B8E062A738EE727F-001/tempDir-001/node3/movereplicatest_coll_shard1_replica_n2],
dataDir=[hdfs://localhost.localdomain:36851/data/movereplicatest_coll/core_node2/data/]
[junit4] 2> 2698724 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll s:shard1 r:core_node2
x:movereplicatest_coll_shard1_replica_n2] o.a.s.c.HdfsDirectoryFactory creating
directory factory for path
hdfs://localhost.localdomain:36851/data/movereplicatest_coll/core_node2/data/snapshot_metadata
[junit4] 2> 2698726 INFO (qtp711907847-26086) [n:127.0.0.1:41069_solr
c:movereplicatest_coll s:shard1 r:core_node1
x:movereplicatest_coll_shard1_replica_n1] o.a.s.s.IndexSchema
[movereplicatest_coll_shard1_replica_n1] Schema name=minimal
[junit4] 2> 2698728 INFO (qtp711907847-26086) [n:127.0.0.1:41069_solr
c:movereplicatest_coll s:shard1 r:core_node1
x:movereplicatest_coll_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 2698728 INFO (qtp711907847-26086) [n:127.0.0.1:41069_solr
c:movereplicatest_coll s:shard1 r:core_node1
x:movereplicatest_coll_shard1_replica_n1] o.a.s.c.CoreContainer Creating
SolrCore 'movereplicatest_coll_shard1_replica_n1' using configuration from
collection movereplicatest_coll, trusted=true
[junit4] 2> 2698728 INFO (qtp711907847-26086) [n:127.0.0.1:41069_solr
c:movereplicatest_coll s:shard1 r:core_node1
x:movereplicatest_coll_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_41069.solr.core.movereplicatest_coll.shard1.replica_n1'
(registry 'solr.core.movereplicatest_coll.shard1.replica_n1') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@3b5799f2
[junit4] 2> 2698728 INFO (qtp711907847-26086) [n:127.0.0.1:41069_solr
c:movereplicatest_coll s:shard1 r:core_node1
x:movereplicatest_coll_shard1_replica_n1] o.a.s.c.HdfsDirectoryFactory
solr.hdfs.home=hdfs://localhost.localdomain:36851/data
[junit4] 2> 2698728 INFO (qtp711907847-26086) [n:127.0.0.1:41069_solr
c:movereplicatest_coll s:shard1 r:core_node1
x:movereplicatest_coll_shard1_replica_n1] o.a.s.c.HdfsDirectoryFactory Solr
Kerberos Authentication disabled
[junit4] 2> 2698728 INFO (qtp711907847-26086) [n:127.0.0.1:41069_solr
c:movereplicatest_coll s:shard1 r:core_node1
x:movereplicatest_coll_shard1_replica_n1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 2698728 INFO (qtp711907847-26086) [n:127.0.0.1:41069_solr
c:movereplicatest_coll s:shard1 r:core_node1
x:movereplicatest_coll_shard1_replica_n1] o.a.s.c.SolrCore
[[movereplicatest_coll_shard1_replica_n1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaHDFSTest_B8E062A738EE727F-001/tempDir-001/node4/movereplicatest_coll_shard1_replica_n1],
dataDir=[hdfs://localhost.localdomain:36851/data/movereplicatest_coll/core_node1/data/]
[junit4] 2> 2698730 INFO (qtp711907847-26086) [n:127.0.0.1:41069_solr
c:movereplicatest_coll s:shard1 r:core_node1
x:movereplicatest_coll_shard1_replica_n1] o.a.s.c.HdfsDirectoryFactory creating
directory factory for path
hdfs://localhost.localdomain:36851/data/movereplicatest_coll/core_node1/data/snapshot_metadata
[junit4] 2> 2698736 INFO (qtp1955710585-26107) [n:127.0.0.1:41993_solr
c:movereplicatest_coll s:shard1 r:core_node2
x:movereplicatest_coll_shard1_replica_n2] o.a.s.c.HdfsDirectoryFactory creating
directory factory for path
hdfs://localhost.localdomain:36851/data/movereplicatest_coll/core_node2/data
[junit4] 2> 2698740 INFO (qtp711907847-26086) [n:127.0.0.1:41069_solr
c:movereplicatest_coll s:shard1 r:core_node1
x:movereplicatest_coll_shard1_replica_n1] o.a.s.c.HdfsDirectoryFactory creating
directory factory for path
hdfs://localhost.localdomain:36851/data/movereplicatest_coll/core_node1/data
[junit4] 2> 2698761 INFO (qtp1500762002-26111) [n:127.0.0.1:39175_solr
c:movereplicatest_coll s:shard2 r:core_node4
x:movereplicatest_coll_shard2_replica_n2] o.a.s.c.SolrConfig Using Luce
[...truncated too long message...]
(MetricsSourceAdapter.java:211)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSystemImpl.stopSources(MetricsSystemImpl.java:463)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSystemImpl.stop(MetricsSystemImpl.java:213)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSystemImpl.shutdown(MetricsSystemImpl.java:594)
[junit4] 2> at
org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdownInstance(DefaultMetricsSystem.java:72)
[junit4] 2> at
org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdown(DefaultMetricsSystem.java:68)
[junit4] 2> at
org.apache.hadoop.hdfs.server.namenode.metrics.NameNodeMetrics.shutdown(NameNodeMetrics.java:171)
[junit4] 2> at
org.apache.hadoop.hdfs.server.namenode.NameNode.stop(NameNode.java:872)
[junit4] 2> at
org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1726)
[junit4] 2> at
org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1705)
[junit4] 2> at
org.apache.solr.cloud.hdfs.HdfsTestUtil.teardownClass(HdfsTestUtil.java:204)
[junit4] 2> at
org.apache.solr.cloud.MoveReplicaHDFSTest.teardownClass(MoveReplicaHDFSTest.java:63)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native
Method)
[junit4] 2> at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] 2> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:870)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> Caused by: java.lang.NullPointerException
[junit4] 2> at
org.apache.hadoop.hdfs.server.blockmanagement.BlocksMap.size(BlocksMap.java:203)
[junit4] 2> at
org.apache.hadoop.hdfs.server.blockmanagement.BlockManager.getTotalBlocks(BlockManager.java:3370)
[junit4] 2> at
org.apache.hadoop.hdfs.server.namenode.FSNamesystem.getBlocksTotal(FSNamesystem.java:5729)
[junit4] 2> ... 54 more
[junit4] 2> 2723506 INFO
(SUITE-MoveReplicaHDFSTest-seed#[B8E062A738EE727F]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:36093 36093
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaHDFSTest_B8E062A738EE727F-001
[junit4] 2> Jul 12, 2017 10:51:02 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 66 leaked
thread(s).
[junit4] 2> NOTE: test params are:
codec=HighCompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=HIGH_COMPRESSION,
chunkSize=27556, maxDocsPerChunk=7, blockSize=347),
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=HIGH_COMPRESSION,
chunkSize=27556, blockSize=347)), sim=RandomSimilarity(queryNorm=true): {},
locale=sr, timezone=EST
[junit4] 2> NOTE: Linux 4.10.0-26-generic amd64/Oracle Corporation
1.8.0_131 (64-bit)/cpus=8,threads=5,free=171849528,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestQueryUtils,
HardAutoCommitTest, ExitableDirectoryReaderTest,
LeaderInitiatedRecoveryOnShardRestartTest, TestRawTransformer,
NumericFieldsTest, SimplePostToolTest, TestGroupingSearch,
TestUseDocValuesAsStored2, SimpleFacetsTest, TestFieldCacheReopen,
DistributedQueueTest, BasicDistributedZk2Test, TestSubQueryTransformer,
TestSolrConfigHandler, TestDistribIDF, HdfsBasicDistributedZk2Test,
TestCloudJSONFacetJoinDomain, V2StandaloneTest, TestInPlaceUpdatesDistrib,
SSLMigrationTest, CdcrReplicationHandlerTest, TestSolrDeletionPolicy2,
TestStressLiveNodes, TestReplicationHandlerBackup, SortByFunctionTest,
TestRuleBasedAuthorizationPlugin, TestPayloadCheckQParserPlugin,
DeleteInactiveReplicaTest, DirectUpdateHandlerOptimizeTest, AddBlockUpdateTest,
TermVectorComponentDistributedTest, EnumFieldTest, TestDFRSimilarityFactory,
ConfigureRecoveryStrategyTest, ClassificationUpdateProcessorTest,
ReplicaListTransformerTest, TestJsonRequest, TestSolrCoreSnapshots,
PreAnalyzedFieldTest, TestMacroExpander, CoreMergeIndexesAdminHandlerTest,
TestCustomSort, TestSchemaNameResource, TimeZoneUtilsTest,
FullSolrCloudDistribCmdsTest, UnloadDistributedZkTest, TestNumericTerms32,
TestIndexSearcher, TestSizeLimitedDistributedMap, ClusterStateTest,
TestClusterStateMutator, BlockDirectoryTest, TestConfigSetsAPI,
SharedFSAutoReplicaFailoverTest, BlobRepositoryCloudTest,
SolrCloudReportersTest, AutoCommitTest, SolrTestCaseJ4Test,
CleanupOldIndexTest, HdfsUnloadDistributedZkTest, TestSimpleQParserPlugin,
TestFreeTextSuggestions, SearchHandlerTest, SolrCoreCheckLockOnStartupTest,
TestCryptoKeys, DistributedFacetPivotWhiteBoxTest, SmileWriterTest,
LeaderFailoverAfterPartitionTest, RecoveryAfterSoftCommitTest,
TestBackupRepositoryFactory, TestExportWriter, CollectionStateFormat2Test,
ImplicitSnitchTest, TestDistributedMissingSort, StatsComponentTest,
PolyFieldTest, TestSolrCoreParser, SolrMetricReporterTest, HdfsSyncSliceTest,
TestGraphTermsQParserPlugin, SolrInfoBeanTest, DirectUpdateHandlerTest,
MetricsConfigTest, TestConfigSetProperties, SuggesterTest,
TestNumericTokenStream, CollectionsAPISolrJTest, HdfsChaosMonkeySafeLeaderTest,
TestLegacyNumericRangeQueryBuilder, TestAnalyzeInfixSuggestions,
StatsReloadRaceTest, TestSQLHandler, TestStressUserVersions, TestCustomStream,
TestDownShardTolerantSearch, DistribCursorPagingTest, MultiTermTest,
TestManagedSchemaAPI, MetricUtilsTest, TestMinMaxOnMultiValuedField,
DistributedExpandComponentTest, TestClassicSimilarityFactory, RecoveryZkTest,
SolrCLIZkUtilsTest, TestPseudoReturnFields, TestAuthenticationFramework,
TestSchemaVersionResource, ResponseLogComponentTest, OverseerTest,
ReturnFieldsTest, BitVectorTest, TestRandomCollapseQParserPlugin,
TestReplicaProperties, TestLFUCache, CollectionsAPIDistributedZkTest,
LeaderElectionIntegrationTest, TestReplicationHandler, TestRandomFaceting,
TestZkChroot, TestRandomDVFaceting, TestFaceting, TestRecovery,
TestHashPartitioner, DistributedSpellCheckComponentTest, TestRealTimeGet,
TestJoin, TestSolr4Spatial, BadIndexSchemaTest, TestSort, SoftAutoCommitTest,
TestWordDelimiterFilterFactory, DefaultValueUpdateProcessorTest,
TestRemoteStreaming, DistanceFunctionTest, DebugComponentTest,
DisMaxRequestHandlerTest, TestReversedWildcardFilterFactory,
DocumentAnalysisRequestHandlerTest, LoggingHandlerTest, SolrPluginUtilsTest,
TestCollationField, TestCSVResponseWriter,
UniqFieldsUpdateProcessorFactoryTest, JsonLoaderTest, PingRequestHandlerTest,
TestMergePolicyConfig, SampleTest, TestBinaryField, MinimalSchemaTest,
TestElisionMultitermQuery, TestConfig, TestFuzzyAnalyzedSuggestions,
ExternalFileFieldSortTest, TestSolrCoreProperties, DirectSolrConnectionTest,
NotRequiredUniqueKeyTest, TestLuceneMatchVersion, SpellPossibilityIteratorTest,
TestCharFilters, TestCodecSupport, TestSweetSpotSimilarityFactory,
TestPerFieldSimilarity, TestLMJelinekMercerSimilarityFactory,
TestIBSimilarityFactory, TestBM25SimilarityFactory, TestFastWriter,
TestFastOutputStream, URLClassifyProcessorTest, DateMathParserTest,
TestSystemIdResolver, TestSuggestSpellingConverter, DateFieldTest,
SpellingQueryConverterTest, DOMUtilTest, RAMDirectoryFactoryTest, TestSolrJ,
TestUtils, TestDocumentBuilder, ZkNodePropsTest, SystemInfoHandlerTest,
CircularListTest, DistributedMLTComponentTest, TestHighlightDedupGrouping,
TestSimpleTrackingShardHandler, AliasIntegrationTest,
ChaosMonkeyNothingIsSafeWithPullReplicasTest,
CollectionsAPIAsyncDistributedZkTest, CustomCollectionTest, DeleteStatusTest,
DistribDocExpirationUpdateProcessorTest, MigrateRouteKeyTest,
MoveReplicaHDFSTest]
[junit4] Completed [530/727 (1!)] on J2 in 80.65s, 2 tests, 1 failure <<<
FAILURES!
[...truncated 44028 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org
