You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2018/06/27 18:57:23 UTC
[JENKINS] Lucene-Solr-7.x-Linux (64bit/jdk-10) - Build # 2208 -
Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/2208/
Java: 64bit/jdk-10 -XX:+UseCompressedOops -XX:+UseG1GC
2 tests failed.
FAILED: org.apache.solr.cloud.MoveReplicaHDFSTest.testFailedMove
Error Message:
No live SolrServers available to handle this request:[http://127.0.0.1:33813/solr/MoveReplicaHDFSTest_failed_coll_true, http://127.0.0.1:45383/solr/MoveReplicaHDFSTest_failed_coll_true]
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:33813/solr/MoveReplicaHDFSTest_failed_coll_true, http://127.0.0.1:45383/solr/MoveReplicaHDFSTest_failed_coll_true]
at __randomizedtesting.SeedInfo.seed([BE22103693A8247A:14EFC3C4247BF1AA]:0)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:462)
at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1106)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:886)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:993)
at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:819)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:942)
at org.apache.solr.cloud.MoveReplicaTest.testFailedMove(MoveReplicaTest.java:288)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:45383/solr/MoveReplicaHDFSTest_failed_coll_true: no servers hosting shard: shard1
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413)
... 45 more
FAILED: org.apache.solr.cloud.MoveReplicaHDFSTest.testFailedMove
Error Message:
No live SolrServers available to handle this request:[http://127.0.0.1:34869/solr/MoveReplicaHDFSTest_failed_coll_true, http://127.0.0.1:37207/solr/MoveReplicaHDFSTest_failed_coll_true]
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:34869/solr/MoveReplicaHDFSTest_failed_coll_true, http://127.0.0.1:37207/solr/MoveReplicaHDFSTest_failed_coll_true]
at __randomizedtesting.SeedInfo.seed([BE22103693A8247A:14EFC3C4247BF1AA]:0)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:462)
at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1106)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:886)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:993)
at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:819)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:942)
at org.apache.solr.cloud.MoveReplicaTest.testFailedMove(MoveReplicaTest.java:288)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:34869/solr/MoveReplicaHDFSTest_failed_coll_true: no servers hosting shard: shard1
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413)
... 45 more
Build Log:
[...truncated 14009 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/J1/temp/solr.cloud.MoveReplicaHDFSTest_BE22103693A8247A-001/init-core-data-001
[junit4] 2> 1366708 WARN (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=19 numCloses=19
[junit4] 2> 1366709 INFO (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1366709 INFO (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 1366709 INFO (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1366709 INFO (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-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/J1/temp/solr.cloud.MoveReplicaHDFSTest_BE22103693A8247A-001/tempDir-001
[junit4] 2> 1366710 INFO (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1366710 INFO (Thread-2907) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1366710 INFO (Thread-2907) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1366711 ERROR (Thread-2907) [ ] 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> 1366810 INFO (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:41399
[junit4] 2> 1366813 INFO (zkConnectionManagerCallback-4006-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1366814 INFO (jetty-launcher-4003-thread-1) [ ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 10+46
[junit4] 2> 1366814 INFO (jetty-launcher-4003-thread-2) [ ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 10+46
[junit4] 2> 1366814 INFO (jetty-launcher-4003-thread-3) [ ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 10+46
[junit4] 2> 1366824 INFO (jetty-launcher-4003-thread-4) [ ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 10+46
[junit4] 2> 1366835 INFO (jetty-launcher-4003-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1366835 INFO (jetty-launcher-4003-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1366835 INFO (jetty-launcher-4003-thread-3) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1366836 INFO (jetty-launcher-4003-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1366836 INFO (jetty-launcher-4003-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1366836 INFO (jetty-launcher-4003-thread-4) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1366836 INFO (jetty-launcher-4003-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@c433f1a{/solr,null,AVAILABLE}
[junit4] 2> 1366837 INFO (jetty-launcher-4003-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@308f63a1{HTTP/1.1,[http/1.1]}{127.0.0.1:37295}
[junit4] 2> 1366837 INFO (jetty-launcher-4003-thread-3) [ ] o.e.j.s.Server Started @1366907ms
[junit4] 2> 1366837 INFO (jetty-launcher-4003-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=37295}
[junit4] 2> 1366837 ERROR (jetty-launcher-4003-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1366837 INFO (jetty-launcher-4003-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1366837 INFO (jetty-launcher-4003-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.5.0
[junit4] 2> 1366837 INFO (jetty-launcher-4003-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1366837 INFO (jetty-launcher-4003-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1366837 INFO (jetty-launcher-4003-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-06-27T18:28:20.877917Z
[junit4] 2> 1366839 INFO (jetty-launcher-4003-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4bafa685{/solr,null,AVAILABLE}
[junit4] 2> 1366840 INFO (jetty-launcher-4003-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6eb87d13{HTTP/1.1,[http/1.1]}{127.0.0.1:38271}
[junit4] 2> 1366840 INFO (jetty-launcher-4003-thread-4) [ ] o.e.j.s.Server Started @1366910ms
[junit4] 2> 1366840 INFO (jetty-launcher-4003-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=38271}
[junit4] 2> 1366840 ERROR (jetty-launcher-4003-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1366840 INFO (jetty-launcher-4003-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1366840 INFO (jetty-launcher-4003-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.5.0
[junit4] 2> 1366840 INFO (jetty-launcher-4003-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1366840 INFO (jetty-launcher-4003-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1366840 INFO (jetty-launcher-4003-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-06-27T18:28:20.880598Z
[junit4] 2> 1366847 INFO (jetty-launcher-4003-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1366847 INFO (jetty-launcher-4003-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1366847 INFO (zkConnectionManagerCallback-4010-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1366847 INFO (jetty-launcher-4003-thread-2) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1366848 INFO (jetty-launcher-4003-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1366848 INFO (zkConnectionManagerCallback-4008-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1366848 INFO (jetty-launcher-4003-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@10171dbd{/solr,null,AVAILABLE}
[junit4] 2> 1366848 INFO (jetty-launcher-4003-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1366848 INFO (jetty-launcher-4003-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1366848 INFO (jetty-launcher-4003-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1366848 INFO (jetty-launcher-4003-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1366848 INFO (jetty-launcher-4003-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@470a2f43{HTTP/1.1,[http/1.1]}{127.0.0.1:39617}
[junit4] 2> 1366848 INFO (jetty-launcher-4003-thread-2) [ ] o.e.j.s.Server Started @1366918ms
[junit4] 2> 1366848 INFO (jetty-launcher-4003-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=39617}
[junit4] 2> 1366848 INFO (jetty-launcher-4003-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@14ffe7de{/solr,null,AVAILABLE}
[junit4] 2> 1366848 ERROR (jetty-launcher-4003-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1366848 INFO (jetty-launcher-4003-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1366849 INFO (jetty-launcher-4003-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@19a07ef2{HTTP/1.1,[http/1.1]}{127.0.0.1:45265}
[junit4] 2> 1366849 INFO (jetty-launcher-4003-thread-1) [ ] o.e.j.s.Server Started @1366919ms
[junit4] 2> 1366849 INFO (jetty-launcher-4003-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.5.0
[junit4] 2> 1366849 INFO (jetty-launcher-4003-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1366849 INFO (jetty-launcher-4003-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=45265}
[junit4] 2> 1366849 INFO (jetty-launcher-4003-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1366849 INFO (jetty-launcher-4003-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-06-27T18:28:20.889115Z
[junit4] 2> 1366849 ERROR (jetty-launcher-4003-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1366849 INFO (jetty-launcher-4003-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1366849 INFO (jetty-launcher-4003-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.5.0
[junit4] 2> 1366849 INFO (jetty-launcher-4003-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1366849 INFO (jetty-launcher-4003-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1366849 INFO (jetty-launcher-4003-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-06-27T18:28:20.889296Z
[junit4] 2> 1366860 INFO (zkConnectionManagerCallback-4012-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1366861 INFO (jetty-launcher-4003-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1366863 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x100c5018a130003, likely client has closed socket
[junit4] 2> 1366863 INFO (zkConnectionManagerCallback-4014-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1366863 INFO (jetty-launcher-4003-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1366923 INFO (jetty-launcher-4003-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41399/solr
[junit4] 2> 1366925 INFO (zkConnectionManagerCallback-4018-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1366927 INFO (zkConnectionManagerCallback-4020-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1366944 INFO (jetty-launcher-4003-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41399/solr
[junit4] 2> 1366951 INFO (zkConnectionManagerCallback-4026-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1366953 INFO (zkConnectionManagerCallback-4028-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1366957 INFO (jetty-launcher-4003-thread-2) [n:127.0.0.1:39617_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1366957 INFO (jetty-launcher-4003-thread-2) [n:127.0.0.1:39617_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:39617_solr
[junit4] 2> 1366958 INFO (jetty-launcher-4003-thread-2) [n:127.0.0.1:39617_solr ] o.a.s.c.Overseer Overseer (id=72274204440068104-127.0.0.1:39617_solr-n_0000000000) starting
[junit4] 2> 1366968 INFO (jetty-launcher-4003-thread-3) [n:127.0.0.1:37295_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1366968 INFO (jetty-launcher-4003-thread-3) [n:127.0.0.1:37295_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:37295_solr
[junit4] 2> 1366979 INFO (zkCallback-4027-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1366981 INFO (jetty-launcher-4003-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41399/solr
[junit4] 2> 1366983 INFO (zkConnectionManagerCallback-4035-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1366983 INFO (zkCallback-4019-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1366984 INFO (zkConnectionManagerCallback-4039-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1366984 INFO (jetty-launcher-4003-thread-2) [n:127.0.0.1:39617_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1366985 INFO (jetty-launcher-4003-thread-2) [n:127.0.0.1:39617_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41399/solr ready
[junit4] 2> 1366988 INFO (zkConnectionManagerCallback-4041-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1366989 INFO (zkConnectionManagerCallback-4046-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1366990 INFO (jetty-launcher-4003-thread-2) [n:127.0.0.1:39617_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1366990 INFO (jetty-launcher-4003-thread-2) [n:127.0.0.1:39617_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:39617_solr
[junit4] 2> 1366990 INFO (jetty-launcher-4003-thread-3) [n:127.0.0.1:37295_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1366990 INFO (zkCallback-4027-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1366991 INFO (zkCallback-4034-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1366991 INFO (jetty-launcher-4003-thread-3) [n:127.0.0.1:37295_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41399/solr ready
[junit4] 2> 1366991 INFO (zkCallback-4045-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1366991 INFO (jetty-launcher-4003-thread-3) [n:127.0.0.1:37295_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1366997 INFO (jetty-launcher-4003-thread-1) [n:127.0.0.1:45265_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1366998 INFO (jetty-launcher-4003-thread-1) [n:127.0.0.1:45265_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1366999 INFO (jetty-launcher-4003-thread-1) [n:127.0.0.1:45265_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1366999 INFO (jetty-launcher-4003-thread-1) [n:127.0.0.1:45265_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:45265_solr
[junit4] 2> 1367000 INFO (zkCallback-4019-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1367000 INFO (zkCallback-4034-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1367000 INFO (zkCallback-4027-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1367000 INFO (zkCallback-4045-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1367001 INFO (zkCallback-4019-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1367001 INFO (zkCallback-4040-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1367003 INFO (jetty-launcher-4003-thread-3) [n:127.0.0.1:37295_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37295.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6fa2ae3
[junit4] 2> 1367004 INFO (jetty-launcher-4003-thread-2) [n:127.0.0.1:39617_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1367010 INFO (jetty-launcher-4003-thread-3) [n:127.0.0.1:37295_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37295.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6fa2ae3
[junit4] 2> 1367011 INFO (jetty-launcher-4003-thread-3) [n:127.0.0.1:37295_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37295.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6fa2ae3
[junit4] 2> 1367011 INFO (jetty-launcher-4003-thread-3) [n:127.0.0.1:37295_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BE22103693A8247A-001/tempDir-001/node3/.
[junit4] 2> 1367014 INFO (jetty-launcher-4003-thread-2) [n:127.0.0.1:39617_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39617.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6fa2ae3
[junit4] 2> 1367019 INFO (jetty-launcher-4003-thread-2) [n:127.0.0.1:39617_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39617.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6fa2ae3
[junit4] 2> 1367019 INFO (jetty-launcher-4003-thread-2) [n:127.0.0.1:39617_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39617.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6fa2ae3
[junit4] 2> 1367020 INFO (jetty-launcher-4003-thread-2) [n:127.0.0.1:39617_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BE22103693A8247A-001/tempDir-001/node2/.
[junit4] 2> 1367026 INFO (zkConnectionManagerCallback-4055-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1367027 INFO (jetty-launcher-4003-thread-1) [n:127.0.0.1:45265_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 1367028 INFO (jetty-launcher-4003-thread-1) [n:127.0.0.1:45265_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41399/solr ready
[junit4] 2> 1367035 INFO (jetty-launcher-4003-thread-1) [n:127.0.0.1:45265_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1367040 INFO (jetty-launcher-4003-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41399/solr
[junit4] 2> 1367044 INFO (zkConnectionManagerCallback-4060-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1367045 INFO (zkConnectionManagerCallback-4062-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1367048 INFO (jetty-launcher-4003-thread-4) [n:127.0.0.1:38271_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 1367048 INFO (jetty-launcher-4003-thread-1) [n:127.0.0.1:45265_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45265.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6fa2ae3
[junit4] 2> 1367049 INFO (jetty-launcher-4003-thread-4) [n:127.0.0.1:38271_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1367050 INFO (jetty-launcher-4003-thread-4) [n:127.0.0.1:38271_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1367050 INFO (jetty-launcher-4003-thread-4) [n:127.0.0.1:38271_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38271_solr
[junit4] 2> 1367051 INFO (zkCallback-4040-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1367051 INFO (zkCallback-4034-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1367051 INFO (zkCallback-4019-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1367051 INFO (zkCallback-4045-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1367051 INFO (zkCallback-4027-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1367051 INFO (zkCallback-4054-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1367052 INFO (zkCallback-4061-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1367057 INFO (jetty-launcher-4003-thread-1) [n:127.0.0.1:45265_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45265.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6fa2ae3
[junit4] 2> 1367057 INFO (jetty-launcher-4003-thread-1) [n:127.0.0.1:45265_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45265.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6fa2ae3
[junit4] 2> 1367058 INFO (jetty-launcher-4003-thread-1) [n:127.0.0.1:45265_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BE22103693A8247A-001/tempDir-001/node1/.
[junit4] 2> 1367059 INFO (zkConnectionManagerCallback-4069-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1367060 INFO (jetty-launcher-4003-thread-4) [n:127.0.0.1:38271_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1367060 INFO (jetty-launcher-4003-thread-4) [n:127.0.0.1:38271_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41399/solr ready
[junit4] 2> 1367063 INFO (jetty-launcher-4003-thread-4) [n:127.0.0.1:38271_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1367071 INFO (jetty-launcher-4003-thread-4) [n:127.0.0.1:38271_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38271.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6fa2ae3
[junit4] 2> 1367076 INFO (jetty-launcher-4003-thread-4) [n:127.0.0.1:38271_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38271.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6fa2ae3
[junit4] 2> 1367076 INFO (jetty-launcher-4003-thread-4) [n:127.0.0.1:38271_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38271.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6fa2ae3
[junit4] 2> 1367077 INFO (jetty-launcher-4003-thread-4) [n:127.0.0.1:38271_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BE22103693A8247A-001/tempDir-001/node4/.
[junit4] 2> 1367099 INFO (zkConnectionManagerCallback-4072-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1367101 INFO (zkConnectionManagerCallback-4077-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1367102 INFO (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1367103 INFO (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41399/solr ready
[junit4] 2> 1367106 INFO (qtp329223389-13851) [n:127.0.0.1:37295_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1367108 INFO (qtp329223389-13851) [n:127.0.0.1:37295_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=2
[junit4] 1> Formatting using clusterid: testClusterID
[junit4] 2> 1367172 WARN (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4] 2> 1367206 WARN (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 1367207 INFO (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.m.log jetty-6.1.26
[junit4] 2> 1367210 INFO (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.m.log Extract jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.4-tests.jar!/webapps/hdfs to ./temp/Jetty_localhost_localdomain_35915_hdfs____.3c5j1n/webapp
[junit4] 2> 1367287 INFO (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost.localdomain:35915
[junit4] 2> 1367342 WARN (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 1367343 INFO (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.m.log jetty-6.1.26
[junit4] 2> 1367345 INFO (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.m.log Extract jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.4-tests.jar!/webapps/datanode to ./temp/Jetty_localhost_36541_datanode____qgnwk6/webapp
[junit4] 2> 1367409 INFO (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:36541
[junit4] 2> 1367432 WARN (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 1367433 INFO (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.m.log jetty-6.1.26
[junit4] 2> 1367435 INFO (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.m.log Extract jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.4-tests.jar!/webapps/datanode to ./temp/Jetty_localhost_43377_datanode____.tvy1lx/webapp
[junit4] 2> 1367509 ERROR (DataNode: [[[DISK]file:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BE22103693A8247A-001/tempDir-002/hdfsBaseDir/data/data1/, [DISK]file:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BE22103693A8247A-001/tempDir-002/hdfsBaseDir/data/data2/]] heartbeating to localhost.localdomain/127.0.0.1:34189) [ ] o.a.h.h.s.d.DirectoryScanner dfs.datanode.directoryscan.throttle.limit.ms.per.sec set to value below 1 ms/sec. Assuming default value of 1000
[junit4] 2> 1367515 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0xbbe12ecfe851f: from storage DS-bba263c7-b24b-4cfe-bc06-2238cc6cbf38 node DatanodeRegistration(127.0.0.1:41943, datanodeUuid=ea46283d-f40f-43ab-9fdf-61c6b7766f97, infoPort=46763, infoSecurePort=0, ipcPort=44875, storageInfo=lv=-56;cid=testClusterID;nsid=896042762;c=0), blocks: 0, hasStaleStorage: true, processing time: 0 msecs
[junit4] 2> 1367515 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0xbbe12ecfe851f: from storage DS-33815605-0723-4ad2-b978-cd241e2a4860 node DatanodeRegistration(127.0.0.1:41943, datanodeUuid=ea46283d-f40f-43ab-9fdf-61c6b7766f97, infoPort=46763, infoSecurePort=0, ipcPort=44875, storageInfo=lv=-56;cid=testClusterID;nsid=896042762;c=0), blocks: 0, hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 1367516 INFO (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:43377
[junit4] 2> 1367615 ERROR (DataNode: [[[DISK]file:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BE22103693A8247A-001/tempDir-002/hdfsBaseDir/data/data3/, [DISK]file:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BE22103693A8247A-001/tempDir-002/hdfsBaseDir/data/data4/]] heartbeating to localhost.localdomain/127.0.0.1:34189) [ ] o.a.h.h.s.d.DirectoryScanner dfs.datanode.directoryscan.throttle.limit.ms.per.sec set to value below 1 ms/sec. Assuming default value of 1000
[junit4] 2> 1367618 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0xbbe12f3318735: from storage DS-fc62cba7-c195-4f43-86bf-e0e5a5702b16 node DatanodeRegistration(127.0.0.1:42655, datanodeUuid=fcbafe25-ffa9-4f46-af57-62d7e8e2e706, infoPort=45651, infoSecurePort=0, ipcPort=37915, storageInfo=lv=-56;cid=testClusterID;nsid=896042762;c=0), blocks: 0, hasStaleStorage: true, processing time: 0 msecs
[junit4] 2> 1367618 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0xbbe12f3318735: from storage DS-77d6a2f6-3c5c-41c6-b5fc-ea3b705b20a4 node DatanodeRegistration(127.0.0.1:42655, datanodeUuid=fcbafe25-ffa9-4f46-af57-62d7e8e2e706, infoPort=45651, infoSecurePort=0, ipcPort=37915, storageInfo=lv=-56;cid=testClusterID;nsid=896042762;c=0), blocks: 0, hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 1367698 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testNormalFailedMove
[junit4] 2> 1367699 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1367701 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [ ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 10+46
[junit4] 2> 1367719 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1367719 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1367719 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1367724 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@19821953{/solr,null,AVAILABLE}
[junit4] 2> 1367724 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@115f534d{HTTP/1.1,[http/1.1]}{127.0.0.1:37207}
[junit4] 2> 1367724 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [ ] o.e.j.s.Server Started @1367794ms
[junit4] 2> 1367724 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=37207}
[junit4] 2> 1367724 ERROR (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1367724 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1367724 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.5.0
[junit4] 2> 1367724 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1367724 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1367725 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-06-27T18:28:21.764990Z
[junit4] 2> 1367726 INFO (zkConnectionManagerCallback-4081-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1367726 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1367799 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41399/solr
[junit4] 2> 1367800 INFO (zkConnectionManagerCallback-4085-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1367800 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x100c5018a130014, likely client has closed socket
[junit4] 2> 1367801 INFO (zkConnectionManagerCallback-4087-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1367804 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [n:127.0.0.1:37207_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1367805 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [n:127.0.0.1:37207_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1367806 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [n:127.0.0.1:37207_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1367806 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [n:127.0.0.1:37207_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:37207_solr
[junit4] 2> 1367807 INFO (zkCallback-4040-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1367807 INFO (zkCallback-4034-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1367807 INFO (zkCallback-4054-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1367807 INFO (zkCallback-4045-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1367807 INFO (zkCallback-4019-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1367807 INFO (zkCallback-4027-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1367807 INFO (zkCallback-4061-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1367807 INFO (zkCallback-4076-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1367807 INFO (zkCallback-4076-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1367812 INFO (zkCallback-4086-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1367815 INFO (zkCallback-4068-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1367820 INFO (zkConnectionManagerCallback-4094-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1367820 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [n:127.0.0.1:37207_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
[junit4] 2> 1367821 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [n:127.0.0.1:37207_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41399/solr ready
[junit4] 2> 1367825 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [n:127.0.0.1:37207_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1367836 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [n:127.0.0.1:37207_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37207.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6fa2ae3
[junit4] 2> 1367843 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [n:127.0.0.1:37207_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37207.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6fa2ae3
[junit4] 2> 1367844 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [n:127.0.0.1:37207_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37207.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6fa2ae3
[junit4] 2> 1367845 INFO (TEST-MoveReplicaHDFSTest.testNormalFailedMove-seed#[BE22103693A8247A]) [n:127.0.0.1:37207_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BE22103693A8247A-001/tempDir-001/node5/.
[junit4] 2> 1367891 INFO (zkConnectionManagerCallback-4097-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1367897 INFO (qtp23720966-14170) [n:127.0.0.1:37207_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf1&autoAddReplicas=false&name=MoveReplicaHDFSTest_failed_coll_false&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1367899 INFO (OverseerThreadFactory-5493-thread-2) [ ] o.a.s.c.a.c.CreateCollectionCmd Create collection MoveReplicaHDFSTest_failed_coll_false
[junit4] 2> 1367899 INFO (OverseerCollectionConfigSetProcessor-72274204440068104-127.0.0.1:39617_solr-n_0000000000) [ ] 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> 1368002 INFO (OverseerStateUpdate-72274204440068104-127.0.0.1:39617_solr-n_0000000000) [ ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"MoveReplicaHDFSTest_failed_coll_false",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:38271/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1368003 INFO (OverseerStateUpdate-72274204440068104-127.0.0.1:39617_solr-n_0000000000) [ ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"MoveReplicaHDFSTest_failed_coll_false",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:37207/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1368003 INFO (OverseerStateUpdate-72274204440068104-127.0.0.1:39617_solr-n_0000000000) [ ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"MoveReplicaHDFSTest_failed_coll_false",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:45265/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1368004 INFO (OverseerStateUpdate-72274204440068104-127.0.0.1:39617_solr-n_0000000000) [ ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"MoveReplicaHDFSTest_failed_coll_false",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n6",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:39617/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1368209 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf1&newCollection=true&name=MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2&action=CREATE&numShards=2&collection=MoveReplicaHDFSTest_failed_coll_false&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1368209 INFO (qtp341895360-13867) [n:127.0.0.1:39617_solr x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n6] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf1&newCollection=true&name=MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n6&action=CREATE&numShards=2&collection=MoveReplicaHDFSTest_failed_coll_false&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1368209 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf1&newCollection=true&name=MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1&action=CREATE&numShards=2&collection=MoveReplicaHDFSTest_failed_coll_false&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1368210 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf1&newCollection=true&name=MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4&action=CREATE&numShards=2&collection=MoveReplicaHDFSTest_failed_coll_false&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1369217 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
[junit4] 2> 1369217 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
[junit4] 2> 1369217 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
[junit4] 2> 1369232 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.s.IndexSchema [MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] Schema name=minimal
[junit4] 2> 1369232 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.s.IndexSchema [MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] Schema name=minimal
[junit4] 2> 1369242 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.s.IndexSchema [MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] Schema name=minimal
[junit4] 2> 1369242 INFO (qtp341895360-13867) [n:127.0.0.1:39617_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node8 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n6] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
[junit4] 2> 1369243 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1369243 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1369243 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.c.CoreContainer Creating SolrCore 'MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2' using configuration from collection MoveReplicaHDFSTest_failed_coll_false, trusted=true
[junit4] 2> 1369243 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.c.CoreContainer Creating SolrCore 'MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4' using configuration from collection MoveReplicaHDFSTest_failed_coll_false, trusted=true
[junit4] 2> 1369243 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1369243 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1' using configuration from collection MoveReplicaHDFSTest_failed_coll_false, trusted=true
[junit4] 2> 1369244 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38271.solr.core.MoveReplicaHDFSTest_failed_coll_false.shard1.replica_n1' (registry 'solr.core.MoveReplicaHDFSTest_failed_coll_false.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6fa2ae3
[junit4] 2> 1369244 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45265.solr.core.MoveReplicaHDFSTest_failed_coll_false.shard2.replica_n4' (registry 'solr.core.MoveReplicaHDFSTest_failed_coll_false.shard2.replica_n4') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6fa2ae3
[junit4] 2> 1369244 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37207.solr.core.MoveReplicaHDFSTest_failed_coll_false.shard1.replica_n2' (registry 'solr.core.MoveReplicaHDFSTest_failed_coll_false.shard1.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6fa2ae3
[junit4] 2> 1369245 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost.localdomain:34189/data
[junit4] 2> 1369245 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 1369245 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1369245 INFO (qtp341895360-13867) [n:127.0.0.1:39617_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node8 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n6] o.a.s.s.IndexSchema [MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n6] Schema name=minimal
[junit4] 2> 1369246 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.c.SolrCore [[MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BE22103693A8247A-001/tempDir-001/node4/MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1], dataDir=[hdfs://localhost.localdomain:34189/data/MoveReplicaHDFSTest_failed_coll_false/core_node3/data/]
[junit4] 2> 1369246 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost.localdomain:34189/data
[junit4] 2> 1369246 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 1369246 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1369246 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost.localdomain:34189/data
[junit4] 2> 1369246 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 1369246 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.c.SolrCore [[MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BE22103693A8247A-001/tempDir-001/node1/MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4], dataDir=[hdfs://localhost.localdomain:34189/data/MoveReplicaHDFSTest_failed_coll_false/core_node7/data/]
[junit4] 2> 1369246 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1369246 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.c.SolrCore [[MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BE22103693A8247A-001/tempDir-001/node5/MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2], dataDir=[hdfs://localhost.localdomain:34189/data/MoveReplicaHDFSTest_failed_coll_false/core_node5/data/]
[junit4] 2> 1369246 INFO (qtp341895360-13867) [n:127.0.0.1:39617_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node8 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n6] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1369246 INFO (qtp341895360-13867) [n:127.0.0.1:39617_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node8 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n6] o.a.s.c.CoreContainer Creating SolrCore 'MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n6' using configuration from collection MoveReplicaHDFSTest_failed_coll_false, trusted=true
[junit4] 2> 1369247 INFO (qtp341895360-13867) [n:127.0.0.1:39617_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node8 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n6] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39617.solr.core.MoveReplicaHDFSTest_failed_coll_false.shard2.replica_n6' (registry 'solr.core.MoveReplicaHDFSTest_failed_coll_false.shard2.replica_n6') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6fa2ae3
[junit4] 2> 1369247 INFO (qtp341895360-13867) [n:127.0.0.1:39617_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node8 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n6] o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost.localdomain:34189/data
[junit4] 2> 1369247 INFO (qtp341895360-13867) [n:127.0.0.1:39617_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node8 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n6] o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 1369247 INFO (qtp341895360-13867) [n:127.0.0.1:39617_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node8 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n6] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1369247 INFO (qtp341895360-13867) [n:127.0.0.1:39617_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node8 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n6] o.a.s.c.SolrCore [[MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n6] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.MoveReplicaHDFSTest_BE22103693A8247A-001/tempDir-001/node2/MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n6], dataDir=[hdfs://localhost.localdomain:34189/data/MoveReplicaHDFSTest_failed_coll_false/core_node8/data/]
[junit4] 2> 1369247 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost.localdomain:34189/data/MoveReplicaHDFSTest_failed_coll_false/core_node3/data/snapshot_metadata
[junit4] 2> 1369247 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost.localdomain:34189/data/MoveReplicaHDFSTest_failed_coll_false/core_node7/data/snapshot_metadata
[junit4] 2> 1369247 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost.localdomain:34189/data/MoveReplicaHDFSTest_failed_coll_false/core_node5/data/snapshot_metadata
[junit4] 2> 1369247 INFO (qtp341895360-13867) [n:127.0.0.1:39617_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node8 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n6] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost.localdomain:34189/data/MoveReplicaHDFSTest_failed_coll_false/core_node8/data/snapshot_metadata
[junit4] 2> 1369269 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost.localdomain:34189/data/MoveReplicaHDFSTest_failed_coll_false/core_node5/data
[junit4] 2> 1369269 INFO (qtp341895360-13867) [n:127.0.0.1:39617_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node8 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n6] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost.localdomain:34189/data/MoveReplicaHDFSTest_failed_coll_false/core_node8/data
[junit4] 2> 1369269 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost.localdomain:34189/data/MoveReplicaHDFSTest_failed_coll_false/core_node7/data
[junit4] 2> 1369270 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost.localdomain:34189/data/MoveReplicaHDFSTest_failed_coll_false/core_node3/data
[junit4] 2> 1369291 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost.localdomain:34189/data/MoveReplicaHDFSTest_failed_coll_false/core_node5/data/index
[junit4] 2> 1369292 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost.localdomain:34189/data/MoveReplicaHDFSTest_failed_coll_false/core_node3/data/index
[junit4] 2> 1369295 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost.localdomain:34189/data/MoveReplicaHDFSTest_failed_coll_false/core_node7/data/index
[junit4] 2> 1369300 INFO (qtp341895360-13867) [n:127.0.0.1:39617_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node8 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n6] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost.localdomain:34189/data/MoveReplicaHDFSTest_failed_coll_false/core_node8/data/index
[junit4] 2> 1369366 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:41943 is added to blk_1073741826_1002{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-77d6a2f6-3c5c-41c6-b5fc-ea3b705b20a4:NORMAL:127.0.0.1:42655|RBW], ReplicaUC[[DISK]DS-bba263c7-b24b-4cfe-bc06-2238cc6cbf38:NORMAL:127.0.0.1:41943|RBW]]} size 0
[junit4] 2> 1369367 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:42655 is added to blk_1073741825_1001{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-33815605-0723-4ad2-b978-cd241e2a4860:NORMAL:127.0.0.1:41943|RBW], ReplicaUC[[DISK]DS-fc62cba7-c195-4f43-86bf-e0e5a5702b16:NORMAL:127.0.0.1:42655|RBW]]} size 0
[junit4] 2> 1369370 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:41943 is added to blk_1073741825_1001 size 69
[junit4] 2> 1369382 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:42655 is added to blk_1073741826_1002 size 69
[junit4] 2> 1369394 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:41943 is added to blk_1073741828_1004{UCState=COMMITTED, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-33815605-0723-4ad2-b978-cd241e2a4860:NORMAL:127.0.0.1:41943|RBW], ReplicaUC[[DISK]DS-77d6a2f6-3c5c-41c6-b5fc-ea3b705b20a4:NORMAL:127.0.0.1:42655|RBW]]} size 69
[junit4] 2> 1369394 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:41943 is added to blk_1073741827_1003{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-fc62cba7-c195-4f43-86bf-e0e5a5702b16:NORMAL:127.0.0.1:42655|RBW], ReplicaUC[[DISK]DS-bba263c7-b24b-4cfe-bc06-2238cc6cbf38:NORMAL:127.0.0.1:41943|RBW]]} size 0
[junit4] 2> 1369395 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:42655 is added to blk_1073741828_1004 size 69
[junit4] 2> 1369395 INFO (Block report processor) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:42655 is added to blk_1073741827_1003{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-fc62cba7-c195-4f43-86bf-e0e5a5702b16:NORMAL:127.0.0.1:42655|RBW], ReplicaUC[[DISK]DS-bba263c7-b24b-4cfe-bc06-2238cc6cbf38:NORMAL:127.0.0.1:41943|RBW]]} size 0
[junit4] 2> 1369443 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 1369443 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 1369444 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1369444 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1369444 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=3
[junit4] 2> 1369444 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=3
[junit4] 2> 1369444 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 1369444 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1369444 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=3
[junit4] 2> 1369453 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1369453 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1369453 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1369453 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1369454 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1369454 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1369481 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.s.SolrIndexSearcher Opening [Searcher@7e0cbda6[MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] main]
[junit4] 2> 1369485 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.s.SolrIndexSearcher Opening [Searcher@10f18d2b[MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] main]
[junit4] 2> 1369485 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5bf20e81[MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] main]
[junit4] 2> 1369485 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 1369485 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1369486 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 1369486 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 1369486 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1369486 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1369488 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1369488 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1369488 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1369489 INFO (searcherExecutor-5523-thread-1-processing-n:127.0.0.1:38271_solr x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1 c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.c.SolrCore [MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] Registered new searcher Searcher@5bf20e81[MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1369489 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1604451411982024704
[junit4] 2> 1369489 INFO (searcherExecutor-5522-thread-1-processing-n:127.0.0.1:37207_solr x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2 c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.c.SolrCore [MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] Registered new searcher Searcher@10f18d2b[MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1369489 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1604451411982024704
[junit4] 2> 1369489 INFO (searcherExecutor-5521-thread-1-processing-n:127.0.0.1:45265_solr x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4 c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.c.SolrCore [MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] Registered new searcher Searcher@7e0cbda6[MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1369490 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1604451411983073280
[junit4] 2> 1369493 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.c.ZkShardTerms Successful update of terms at /collections/MoveReplicaHDFSTest_failed_coll_false/terms/shard1 to Terms{values={core_node5=0}, version=0}
[junit4] 2> 1369494 INFO (qtp1978912599-13856) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at /collections/MoveReplicaHDFSTest_failed_coll_false/terms/shard1 to Terms{values={core_node3=0, core_node5=0}, version=1}
[junit4] 2> 1369494 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.c.ZkShardTerms Successful update of terms at /collections/MoveReplicaHDFSTest_failed_coll_false/terms/shard2 to Terms{values={core_node7=0}, version=0}
[junit4] 2> 1369495 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1369495 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1369495 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:37207/solr/MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2/
[junit4] 2> 1369495 INFO (qtp1986829362-13870) [n:127.0.0.1:45265_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard2 r:core_node7 x:MoveReplicaHDFSTest_failed_coll_false_shard2_replica_n4] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard2: total=2 found=1 timeoutin=9999ms
[junit4] 2> 1369495 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.u.PeerSync PeerSync: core=MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2 url=http://127.0.0.1:37207/solr START replicas=[http://127.0.0.1:38271/solr/MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1/] nUpdates=100
[junit4] 2> 1369496 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.u.PeerSync PeerSync: core=MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2 url=http://127.0.0.1:37207/solr DONE. We have no versions. sync failed.
[junit4] 2> 1369497 INFO (qtp1978912599-13842) [n:127.0.0.1:38271_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node3 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] o.a.s.c.S.Request [MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n1] webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1369497 INFO (qtp23720966-14165) [n:127.0.0.1:37207_solr c:MoveReplicaHDFSTest_failed_coll_false s:shard1 r:core_node5 x:MoveReplicaHDFSTest_failed_coll_false_shard1_replica_n2] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the nex
[...truncated too long message...]
ystem.java:849) ~[hadoop-hdfs-2.7.4.jar:?]
[junit4] 2> at org.apache.hadoop.fs.FileSystemLinkResolver.resolve(FileSystemLinkResolver.java:81) ~[hadoop-common-2.7.4.jar:?]
[junit4] 2> at org.apache.hadoop.hdfs.DistributedFileSystem.listStatus(DistributedFileSystem.java:860) ~[hadoop-hdfs-2.7.4.jar:?]
[junit4] 2> at org.apache.hadoop.fs.FileSystem.listStatus(FileSystem.java:1517) ~[hadoop-common-2.7.4.jar:?]
[junit4] 2> at org.apache.hadoop.fs.FileSystem.listStatus(FileSystem.java:1557) ~[hadoop-common-2.7.4.jar:?]
[junit4] 2> at org.apache.solr.core.HdfsDirectoryFactory.cleanupOldIndexDirectories(HdfsDirectoryFactory.java:528) [java/:?]
[junit4] 2> at org.apache.solr.core.SolrCore.lambda$cleanupOldIndexDirectories$21(SolrCore.java:3097) [java/:?]
[junit4] 2> at java.lang.Thread.run(Thread.java:844) [?:?]
[junit4] 2> 83473 INFO (jetty-closer-2-thread-5) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@116785e8{/solr,null,UNAVAILABLE}
[junit4] 2> 83474 INFO (jetty-closer-2-thread-5) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 83474 ERROR (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] 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> 83475 INFO (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36313 36313
[junit4] 2> 83597 INFO (Thread-0) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36313 36313
[junit4] 2> 83598 WARN (Thread-0) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 35 /solr/collections/MoveReplicaHDFSTest_coll_false/terms/shard1
[junit4] 2> 20 /solr/collections/MoveReplicaHDFSTest_coll_true/terms/shard2
[junit4] 2> 19 /solr/aliases.json
[junit4] 2> 19 /solr/clusterprops.json
[junit4] 2> 18 /solr/configs/conf1
[junit4] 2> 10 /solr/collections/MoveReplicaHDFSTest_failed_coll_true/terms/shard2
[junit4] 2> 10 /solr/collections/MoveReplicaHDFSTest_coll_false/terms/shard2
[junit4] 2> 10 /solr/collections/MoveReplicaHDFSTest_failed_coll_false/terms/shard1
[junit4] 2> 9 /solr/collections/MoveReplicaHDFSTest_failed_coll_true/terms/shard1
[junit4] 2> 9 /solr/collections/MoveReplicaHDFSTest_failed_coll_false/terms/shard2
[junit4] 2> 7 /solr/security.json
[junit4] 2> 7 /solr/collections/MoveReplicaHDFSTest_coll_true/terms/shard1
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 19 /solr/clusterstate.json
[junit4] 2> 10 /solr/aliases.json
[junit4] 2> 7 /solr/collections/MoveReplicaHDFSTest_coll_true/state.json
[junit4] 2> 7 /solr/collections/MoveReplicaHDFSTest_coll_false/state.json
[junit4] 2> 4 /solr/collections/MoveReplicaHDFSTest_failed_coll_false/state.json
[junit4] 2> 4 /solr/collections/MoveReplicaHDFSTest_failed_coll_true/state.json
[junit4] 2> 3 /solr/collections/MoveReplicaHDFSTest_coll_true/leader_elect/shard2/election/72274292752187404-core_node7-n_0000000000
[junit4] 2> 3 /solr/overseer_elect/election/72274292752187404-127.0.0.1:33813_solr-n_0000000003
[junit4] 2> 2 /solr/collections/MoveReplicaHDFSTest_coll_false/leader_elect/shard1/election/72274292752187403-core_node5-n_0000000001
[junit4] 2> 2 /solr/autoscaling.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 39 /solr/collections
[junit4] 2> 28 /solr/live_nodes
[junit4] 2> 2 /solr/overseer/queue
[junit4] 2> 2 /solr/autoscaling/events/.scheduled_maintenance
[junit4] 2> 2 /solr/autoscaling/events/.auto_add_replicas
[junit4] 2> 2 /solr/overseer/collection-queue-work
[junit4] 2> 2 /solr/overseer/queue-work
[junit4] 2>
[junit4] 2> 83599 WARN (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.a.h.h.s.d.DirectoryScanner DirectoryScanner: shutdown has been called
[junit4] 2> 83665 WARN (DataNode: [[[DISK]file:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.MoveReplicaHDFSTest_BE22103693A8247A-001/tempDir-002/hdfsBaseDir/data/data3/, [DISK]file:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.MoveReplicaHDFSTest_BE22103693A8247A-001/tempDir-002/hdfsBaseDir/data/data4/]] heartbeating to localhost.localdomain/127.0.0.1:40207) [ ] o.a.h.h.s.d.DataNode Ending block pool service for: Block pool BP-1194074947-88.99.242.108-1530125453839 (Datanode Uuid 1b418520-fcba-4711-a862-61e2ca2d2623) service to localhost.localdomain/127.0.0.1:40207
[junit4] 2> 83898 INFO (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.m.log Stopped HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:0
[junit4] 2> 84002 WARN (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.a.h.h.s.d.DirectoryScanner DirectoryScanner: shutdown has been called
[junit4] 2> 84006 INFO (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.m.log Stopped HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:0
[junit4] 2> 84107 WARN (DataNode: [[[DISK]file:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.MoveReplicaHDFSTest_BE22103693A8247A-001/tempDir-002/hdfsBaseDir/data/data1/, [DISK]file:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.MoveReplicaHDFSTest_BE22103693A8247A-001/tempDir-002/hdfsBaseDir/data/data2/]] heartbeating to localhost.localdomain/127.0.0.1:40207) [ ] o.a.h.h.s.d.IncrementalBlockReportManager IncrementalBlockReportManager interrupted
[junit4] 2> 84107 WARN (DataNode: [[[DISK]file:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.MoveReplicaHDFSTest_BE22103693A8247A-001/tempDir-002/hdfsBaseDir/data/data1/, [DISK]file:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.MoveReplicaHDFSTest_BE22103693A8247A-001/tempDir-002/hdfsBaseDir/data/data2/]] heartbeating to localhost.localdomain/127.0.0.1:40207) [ ] o.a.h.h.s.d.DataNode Ending block pool service for: Block pool BP-1194074947-88.99.242.108-1530125453839 (Datanode Uuid 25b2fd0e-398d-432d-ab65-fef392aba0f8) service to localhost.localdomain/127.0.0.1:40207
[junit4] 2> 84115 INFO (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.m.log Stopped HttpServer2$SelectChannelConnectorWithSafeStartup@localhost.localdomain:0
[junit4] 2> 84229 INFO (SUITE-MoveReplicaHDFSTest-seed#[BE22103693A8247A]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36313 36313
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.MoveReplicaHDFSTest_BE22103693A8247A-001
[junit4] 2> Jun 27, 2018 6:52:09 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 66 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=FastDecompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST_DECOMPRESSION, chunkSize=11488, maxDocsPerChunk=7, blockSize=6), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST_DECOMPRESSION, chunkSize=11488, blockSize=6)), sim=RandomSimilarity(queryNorm=false): {}, locale=si-LK, timezone=Etc/GMT-5
[junit4] 2> NOTE: Linux 4.13.0-41-generic amd64/Oracle Corporation 10 (64-bit)/cpus=8,threads=6,free=306319600,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [MoveReplicaHDFSTest]
[junit4] Completed [2/5 (1!)] on J0 in 92.92s, 4 tests, 1 error <<< FAILURES!
[...truncated 33 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/common-build.xml:1568: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/common-build.xml:1092: There were test failures: 5 suites, 20 tests, 1 error [seed: BE22103693A8247A]
Total time: 3 minutes 6 seconds
[repro] Setting last failure code to 256
[repro] Failures:
[repro] 1/5 failed: org.apache.solr.cloud.MoveReplicaHDFSTest
[repro] Exiting with code 256
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all warnings.
<Git Blamer> GIT_COMMIT=19e7466a79ae994c27bec449e980f646d77fcf99, workspace=/var/lib/jenkins/workspace/Lucene-Solr-7.x-Linux
[WARNINGS] Computing warning deltas based on reference build #2207
Recording test results
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[JENKINS] Lucene-Solr-7.x-Linux (64bit/jdk-10.0.1) - Build # 2209 -
Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/2209/
Java: 64bit/jdk-10.0.1 -XX:-UseCompressedOops -XX:+UseSerialGC
11 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates
Error Message:
Stack Trace:
java.lang.NullPointerException
at __randomizedtesting.SeedInfo.seed([F50D49E115673B5A]:0)
at org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates.createMiniSolrCloudCluster(TestStressCloudBlindAtomicUpdates.java:138)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:874)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates
Error Message:
Stack Trace:
java.lang.NullPointerException
at __randomizedtesting.SeedInfo.seed([F50D49E115673B5A]:0)
at org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates.afterClass(TestStressCloudBlindAtomicUpdates.java:158)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:897)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates
Error Message:
ObjectTracker found 1 object(s) that were not released!!! [InternalHttpClient] org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.http.impl.client.InternalHttpClient at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:319) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:328) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:266) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:253) at org.apache.solr.client.solrj.impl.HttpSolrClient.<init>(HttpSolrClient.java:200) at org.apache.solr.client.solrj.impl.HttpSolrClient$Builder.build(HttpSolrClient.java:951) at org.apache.solr.SolrTestCaseJ4.getHttpSolrClient(SolrTestCaseJ4.java:2572) at org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates.createMiniSolrCloudCluster(TestStressCloudBlindAtomicUpdates.java:138) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:874) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.base/java.lang.Thread.run(Thread.java:844)
Stack Trace:
java.lang.AssertionError: ObjectTracker found 1 object(s) that were not released!!! [InternalHttpClient]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.http.impl.client.InternalHttpClient
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:319)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:328)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:266)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:253)
at org.apache.solr.client.solrj.impl.HttpSolrClient.<init>(HttpSolrClient.java:200)
at org.apache.solr.client.solrj.impl.HttpSolrClient$Builder.build(HttpSolrClient.java:951)
at org.apache.solr.SolrTestCaseJ4.getHttpSolrClient(SolrTestCaseJ4.java:2572)
at org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates.createMiniSolrCloudCluster(TestStressCloudBlindAtomicUpdates.java:138)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:874)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
at __randomizedtesting.SeedInfo.seed([F50D49E115673B5A]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNull(Assert.java:551)
at org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:304)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:897)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates
Error Message:
1 thread leaked from SUITE scope at org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates: 1) Thread[id=919, name=Connection evictor, state=TIMED_WAITING, group=TGRP-TestStressCloudBlindAtomicUpdates] at java.base@10.0.1/java.lang.Thread.sleep(Native Method) at app//org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66) at java.base@10.0.1/java.lang.Thread.run(Thread.java:844)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates:
1) Thread[id=919, name=Connection evictor, state=TIMED_WAITING, group=TGRP-TestStressCloudBlindAtomicUpdates]
at java.base@10.0.1/java.lang.Thread.sleep(Native Method)
at app//org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
at java.base@10.0.1/java.lang.Thread.run(Thread.java:844)
at __randomizedtesting.SeedInfo.seed([F50D49E115673B5A]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates
Error Message:
Stack Trace:
java.lang.NullPointerException
at __randomizedtesting.SeedInfo.seed([F50D49E115673B5A]:0)
at org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates.createMiniSolrCloudCluster(TestStressCloudBlindAtomicUpdates.java:138)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:874)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates
Error Message:
Stack Trace:
java.lang.NullPointerException
at __randomizedtesting.SeedInfo.seed([F50D49E115673B5A]:0)
at org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates.afterClass(TestStressCloudBlindAtomicUpdates.java:158)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:897)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates
Error Message:
ObjectTracker found 1 object(s) that were not released!!! [InternalHttpClient] org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.http.impl.client.InternalHttpClient at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:319) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:328) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:266) at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:253) at org.apache.solr.client.solrj.impl.HttpSolrClient.<init>(HttpSolrClient.java:200) at org.apache.solr.client.solrj.impl.HttpSolrClient$Builder.build(HttpSolrClient.java:951) at org.apache.solr.SolrTestCaseJ4.getHttpSolrClient(SolrTestCaseJ4.java:2572) at org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates.createMiniSolrCloudCluster(TestStressCloudBlindAtomicUpdates.java:138) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:874) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.base/java.lang.Thread.run(Thread.java:844)
Stack Trace:
java.lang.AssertionError: ObjectTracker found 1 object(s) that were not released!!! [InternalHttpClient]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.http.impl.client.InternalHttpClient
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:319)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:328)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:266)
at org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:253)
at org.apache.solr.client.solrj.impl.HttpSolrClient.<init>(HttpSolrClient.java:200)
at org.apache.solr.client.solrj.impl.HttpSolrClient$Builder.build(HttpSolrClient.java:951)
at org.apache.solr.SolrTestCaseJ4.getHttpSolrClient(SolrTestCaseJ4.java:2572)
at org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates.createMiniSolrCloudCluster(TestStressCloudBlindAtomicUpdates.java:138)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:874)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
at __randomizedtesting.SeedInfo.seed([F50D49E115673B5A]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNull(Assert.java:551)
at org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:304)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:897)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates
Error Message:
1 thread leaked from SUITE scope at org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates: 1) Thread[id=595, name=Connection evictor, state=TIMED_WAITING, group=TGRP-TestStressCloudBlindAtomicUpdates] at java.base@10.0.1/java.lang.Thread.sleep(Native Method) at app//org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66) at java.base@10.0.1/java.lang.Thread.run(Thread.java:844)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates:
1) Thread[id=595, name=Connection evictor, state=TIMED_WAITING, group=TGRP-TestStressCloudBlindAtomicUpdates]
at java.base@10.0.1/java.lang.Thread.sleep(Native Method)
at app//org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
at java.base@10.0.1/java.lang.Thread.run(Thread.java:844)
at __randomizedtesting.SeedInfo.seed([F50D49E115673B5A]:0)
FAILED: org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.testDelegationTokenRenew
Error Message:
expected:<200> but was:<403>
Stack Trace:
java.lang.AssertionError: expected:<200> but was:<403>
at __randomizedtesting.SeedInfo.seed([F50D49E115673B5A:C296BDFF2DABE6FE]: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.junit.Assert.assertEquals(Assert.java:456)
at org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.renewDelegationToken(TestSolrCloudWithDelegationTokens.java:132)
at org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.verifyDelegationTokenRenew(TestSolrCloudWithDelegationTokens.java:316)
at org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.testDelegationTokenRenew(TestSolrCloudWithDelegationTokens.java:333)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates.test_dv_stored
Error Message:
Some docs had errors -- check logs expected:<0> but was:<28>
Stack Trace:
java.lang.AssertionError: Some docs had errors -- check logs expected:<0> but was:<28>
at __randomizedtesting.SeedInfo.seed([F50D49E115673B5A:67312865A9200682]: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.TestStressCloudBlindAtomicUpdates.checkField(TestStressCloudBlindAtomicUpdates.java:342)
at org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates.test_dv_stored(TestStressCloudBlindAtomicUpdates.java:210)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates.test_dv
Error Message:
Some docs had errors -- check logs expected:<0> but was:<1>
Stack Trace:
java.lang.AssertionError: Some docs had errors -- check logs expected:<0> but was:<1>
at __randomizedtesting.SeedInfo.seed([F50D49E115673B5A:C3192BA79F3A014B]: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.TestStressCloudBlindAtomicUpdates.checkField(TestStressCloudBlindAtomicUpdates.java:342)
at org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates.test_dv(TestStressCloudBlindAtomicUpdates.java:198)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
Build Log:
[...truncated 13319 lines...]
[junit4] Suite: org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates
[junit4] 2> 746568 INFO (SUITE-TestStressCloudBlindAtomicUpdates-seed#[F50D49E115673B5A]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestStressCloudBlindAtomicUpdates_F50D49E115673B5A-001/init-core-data-001
[junit4] 2> 746568 WARN (SUITE-TestStressCloudBlindAtomicUpdates-seed#[F50D49E115673B5A]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=5 numCloses=5
[junit4] 2> 746569 INFO (SUITE-TestStressCloudBlindAtomicUpdates-seed#[F50D49E115673B5A]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 746584 INFO (SUITE-TestStressCloudBlindAtomicUpdates-seed#[F50D49E115673B5A]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl="SSL overhead seems to cause OutOfMemory when stress testing")
[junit4] 2> 746584 INFO (SUITE-TestStressCloudBlindAtomicUpdates-seed#[F50D49E115673B5A]-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/J0/temp/solr.cloud.TestStressCloudBlindAtomicUpdates_F50D49E115673B5A-001/tempDir-001
[junit4] 2> 746584 INFO (SUITE-TestStressCloudBlindAtomicUpdates-seed#[F50D49E115673B5A]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 746603 INFO (Thread-1497) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 746603 INFO (Thread-1497) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 746620 ERROR (Thread-1497) [ ] 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> 746703 INFO (SUITE-TestStressCloudBlindAtomicUpdates-seed#[F50D49E115673B5A]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:45649
[junit4] 2> 746708 INFO (zkConnectionManagerCallback-1713-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 746712 INFO (jetty-launcher-1710-thread-3) [ ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 10.0.1+10
[junit4] 2> 746712 INFO (jetty-launcher-1710-thread-2) [ ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 10.0.1+10
[junit4] 2> 746715 INFO (jetty-launcher-1710-thread-1) [ ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 10.0.1+10
[junit4] 2> 746716 INFO (jetty-launcher-1710-thread-4) [ ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 10.0.1+10
[junit4] 2> 746717 INFO (jetty-launcher-1710-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 746717 INFO (jetty-launcher-1710-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 746718 INFO (jetty-launcher-1710-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 746718 INFO (jetty-launcher-1710-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@26f1d38c{/solr,null,AVAILABLE}
[junit4] 2> 746719 INFO (jetty-launcher-1710-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 746720 INFO (jetty-launcher-1710-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 746720 INFO (jetty-launcher-1710-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 746720 INFO (jetty-launcher-1710-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@739a5d50{HTTP/1.1,[http/1.1]}{127.0.0.1:42979}
[junit4] 2> 746720 INFO (jetty-launcher-1710-thread-1) [ ] o.e.j.s.Server Started @746744ms
[junit4] 2> 746720 INFO (jetty-launcher-1710-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=42979}
[junit4] 2> 746720 INFO (jetty-launcher-1710-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@33d42643{/solr,null,AVAILABLE}
[junit4] 2> 746720 ERROR (jetty-launcher-1710-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 746720 INFO (jetty-launcher-1710-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 746720 INFO (jetty-launcher-1710-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.5.0
[junit4] 2> 746720 INFO (jetty-launcher-1710-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 746720 INFO (jetty-launcher-1710-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 746720 INFO (jetty-launcher-1710-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-06-27T21:23:17.192574Z
[junit4] 2> 746720 INFO (jetty-launcher-1710-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@10d8f90e{HTTP/1.1,[http/1.1]}{127.0.0.1:33309}
[junit4] 2> 746720 INFO (jetty-launcher-1710-thread-2) [ ] o.e.j.s.Server Started @746744ms
[junit4] 2> 746720 INFO (jetty-launcher-1710-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=33309}
[junit4] 2> 746720 ERROR (jetty-launcher-1710-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 746720 INFO (jetty-launcher-1710-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 746720 INFO (jetty-launcher-1710-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.5.0
[junit4] 2> 746721 INFO (jetty-launcher-1710-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 746721 INFO (jetty-launcher-1710-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 746721 INFO (jetty-launcher-1710-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-06-27T21:23:17.193052Z
[junit4] 2> 746722 INFO (zkConnectionManagerCallback-1715-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 746722 INFO (jetty-launcher-1710-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 746723 INFO (jetty-launcher-1710-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 746723 INFO (jetty-launcher-1710-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 746723 INFO (jetty-launcher-1710-thread-4) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 746723 INFO (zkConnectionManagerCallback-1717-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 746723 INFO (jetty-launcher-1710-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 746723 INFO (jetty-launcher-1710-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 746723 INFO (jetty-launcher-1710-thread-3) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 746723 INFO (jetty-launcher-1710-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 746724 INFO (jetty-launcher-1710-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@450dbe5f{/solr,null,AVAILABLE}
[junit4] 2> 746724 INFO (jetty-launcher-1710-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@123cebff{HTTP/1.1,[http/1.1]}{127.0.0.1:34741}
[junit4] 2> 746724 INFO (jetty-launcher-1710-thread-4) [ ] o.e.j.s.Server Started @746748ms
[junit4] 2> 746724 INFO (jetty-launcher-1710-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=34741}
[junit4] 2> 746724 ERROR (jetty-launcher-1710-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 746724 INFO (jetty-launcher-1710-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 746724 INFO (jetty-launcher-1710-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.5.0
[junit4] 2> 746724 INFO (jetty-launcher-1710-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 746724 INFO (jetty-launcher-1710-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 746724 INFO (jetty-launcher-1710-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-06-27T21:23:17.196899Z
[junit4] 2> 746752 INFO (jetty-launcher-1710-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3d6679c3{/solr,null,AVAILABLE}
[junit4] 2> 746752 INFO (jetty-launcher-1710-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@416d8343{HTTP/1.1,[http/1.1]}{127.0.0.1:41793}
[junit4] 2> 746752 INFO (jetty-launcher-1710-thread-3) [ ] o.e.j.s.Server Started @746776ms
[junit4] 2> 746752 INFO (jetty-launcher-1710-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=41793}
[junit4] 2> 746752 INFO (zkConnectionManagerCallback-1719-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 746752 ERROR (jetty-launcher-1710-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 746752 INFO (jetty-launcher-1710-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 746752 INFO (jetty-launcher-1710-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.5.0
[junit4] 2> 746752 INFO (jetty-launcher-1710-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 746752 INFO (jetty-launcher-1710-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 746753 INFO (jetty-launcher-1710-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-06-27T21:23:17.225015Z
[junit4] 2> 746753 INFO (jetty-launcher-1710-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 746787 INFO (zkConnectionManagerCallback-1721-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 746788 INFO (jetty-launcher-1710-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 746884 INFO (jetty-launcher-1710-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45649/solr
[junit4] 2> 746931 INFO (jetty-launcher-1710-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45649/solr
[junit4] 2> 746931 INFO (zkConnectionManagerCallback-1725-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 746958 INFO (zkConnectionManagerCallback-1731-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 746960 INFO (jetty-launcher-1710-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45649/solr
[junit4] 2> 746986 INFO (jetty-launcher-1710-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45649/solr
[junit4] 2> 746988 INFO (zkConnectionManagerCallback-1729-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 746998 INFO (zkConnectionManagerCallback-1735-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 746999 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x100c5a1b35c0008, likely client has closed socket
[junit4] 2> 747024 INFO (jetty-launcher-1710-thread-3) [n:127.0.0.1:41793_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 747024 INFO (jetty-launcher-1710-thread-3) [n:127.0.0.1:41793_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:41793_solr
[junit4] 2> 747025 INFO (jetty-launcher-1710-thread-3) [n:127.0.0.1:41793_solr ] o.a.s.c.Overseer Overseer (id=72274892327485447-127.0.0.1:41793_solr-n_0000000000) starting
[junit4] 2> 747039 INFO (zkConnectionManagerCallback-1741-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 747054 INFO (zkConnectionManagerCallback-1743-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 747060 INFO (jetty-launcher-1710-thread-1) [n:127.0.0.1:42979_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 747061 INFO (jetty-launcher-1710-thread-1) [n:127.0.0.1:42979_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:42979_solr
[junit4] 2> 747083 INFO (zkConnectionManagerCallback-1752-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 747093 INFO (jetty-launcher-1710-thread-3) [n:127.0.0.1:41793_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 747094 INFO (jetty-launcher-1710-thread-3) [n:127.0.0.1:41793_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45649/solr ready
[junit4] 2> 747104 INFO (jetty-launcher-1710-thread-3) [n:127.0.0.1:41793_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 747104 INFO (jetty-launcher-1710-thread-3) [n:127.0.0.1:41793_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41793_solr
[junit4] 2> 747141 INFO (zkCallback-1730-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 747147 INFO (zkCallback-1742-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 747148 INFO (zkConnectionManagerCallback-1745-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 747148 INFO (OverseerStateUpdate-72274892327485447-127.0.0.1:41793_solr-n_0000000000) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 747153 INFO (jetty-launcher-1710-thread-2) [n:127.0.0.1:33309_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 747153 INFO (jetty-launcher-1710-thread-2) [n:127.0.0.1:33309_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 747154 INFO (jetty-launcher-1710-thread-2) [n:127.0.0.1:33309_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 747154 INFO (jetty-launcher-1710-thread-2) [n:127.0.0.1:33309_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33309_solr
[junit4] 2> 747160 INFO (zkCallback-1730-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 747160 INFO (zkConnectionManagerCallback-1748-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 747160 INFO (zkCallback-1742-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
[junit4] 2> 747160 INFO (jetty-launcher-1710-thread-3) [n:127.0.0.1:41793_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 747161 INFO (zkCallback-1744-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 747163 INFO (zkConnectionManagerCallback-1759-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 747171 INFO (zkCallback-1751-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
[junit4] 2> 747180 INFO (jetty-launcher-1710-thread-1) [n:127.0.0.1:42979_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 747181 INFO (jetty-launcher-1710-thread-1) [n:127.0.0.1:42979_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45649/solr ready
[junit4] 2> 747186 INFO (jetty-launcher-1710-thread-3) [n:127.0.0.1:41793_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41793.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70dc7a82
[junit4] 2> 747188 INFO (jetty-launcher-1710-thread-4) [n:127.0.0.1:34741_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 747189 INFO (jetty-launcher-1710-thread-4) [n:127.0.0.1:34741_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 747190 INFO (jetty-launcher-1710-thread-4) [n:127.0.0.1:34741_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 747190 INFO (jetty-launcher-1710-thread-4) [n:127.0.0.1:34741_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34741_solr
[junit4] 2> 747190 INFO (jetty-launcher-1710-thread-1) [n:127.0.0.1:42979_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 747191 INFO (zkConnectionManagerCallback-1767-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 747193 INFO (jetty-launcher-1710-thread-3) [n:127.0.0.1:41793_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41793.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70dc7a82
[junit4] 2> 747193 INFO (jetty-launcher-1710-thread-3) [n:127.0.0.1:41793_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41793.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70dc7a82
[junit4] 2> 747195 INFO (jetty-launcher-1710-thread-3) [n:127.0.0.1:41793_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestStressCloudBlindAtomicUpdates_F50D49E115673B5A-001/tempDir-001/node3/.
[junit4] 2> 747200 INFO (zkCallback-1742-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 747200 INFO (zkCallback-1751-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 747200 INFO (zkCallback-1744-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 747200 INFO (zkCallback-1730-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 747202 INFO (jetty-launcher-1710-thread-1) [n:127.0.0.1:42979_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42979.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70dc7a82
[junit4] 2> 747204 INFO (jetty-launcher-1710-thread-2) [n:127.0.0.1:33309_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 747208 INFO (zkCallback-1758-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 747208 INFO (zkCallback-1747-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 747215 INFO (jetty-launcher-1710-thread-2) [n:127.0.0.1:33309_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45649/solr ready
[junit4] 2> 747231 INFO (jetty-launcher-1710-thread-1) [n:127.0.0.1:42979_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42979.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70dc7a82
[junit4] 2> 747231 INFO (jetty-launcher-1710-thread-1) [n:127.0.0.1:42979_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42979.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70dc7a82
[junit4] 2> 747233 INFO (jetty-launcher-1710-thread-1) [n:127.0.0.1:42979_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestStressCloudBlindAtomicUpdates_F50D49E115673B5A-001/tempDir-001/node1/.
[junit4] 2> 747239 INFO (jetty-launcher-1710-thread-2) [n:127.0.0.1:33309_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 747252 INFO (jetty-launcher-1710-thread-2) [n:127.0.0.1:33309_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33309.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70dc7a82
[junit4] 2> 747259 INFO (jetty-launcher-1710-thread-2) [n:127.0.0.1:33309_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33309.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70dc7a82
[junit4] 2> 747260 INFO (jetty-launcher-1710-thread-2) [n:127.0.0.1:33309_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33309.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70dc7a82
[junit4] 2> 747261 INFO (jetty-launcher-1710-thread-2) [n:127.0.0.1:33309_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestStressCloudBlindAtomicUpdates_F50D49E115673B5A-001/tempDir-001/node2/.
[junit4] 2> 747270 INFO (zkConnectionManagerCallback-1776-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 747270 INFO (jetty-launcher-1710-thread-4) [n:127.0.0.1:34741_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 747271 INFO (jetty-launcher-1710-thread-4) [n:127.0.0.1:34741_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45649/solr ready
[junit4] 2> 747271 INFO (jetty-launcher-1710-thread-4) [n:127.0.0.1:34741_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 747281 INFO (jetty-launcher-1710-thread-4) [n:127.0.0.1:34741_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34741.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70dc7a82
[junit4] 2> 747289 INFO (jetty-launcher-1710-thread-4) [n:127.0.0.1:34741_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34741.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70dc7a82
[junit4] 2> 747289 INFO (jetty-launcher-1710-thread-4) [n:127.0.0.1:34741_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34741.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70dc7a82
[junit4] 2> 747290 INFO (jetty-launcher-1710-thread-4) [n:127.0.0.1:34741_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestStressCloudBlindAtomicUpdates_F50D49E115673B5A-001/tempDir-001/node4/.
[junit4] 2> 747351 INFO (zkConnectionManagerCallback-1779-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 747356 INFO (zkConnectionManagerCallback-1784-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 747357 INFO (SUITE-TestStressCloudBlindAtomicUpdates-seed#[F50D49E115673B5A]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 747357 INFO (SUITE-TestStressCloudBlindAtomicUpdates-seed#[F50D49E115673B5A]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45649/solr ready
[junit4] 2> 747729 INFO (qtp768247097-6631) [n:127.0.0.1:34741_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params property.schema=schema-minimal-atomic-stress.xml&property.config=solrconfig-tlog.xml&collection.configName=org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates_config-set&name=test_col&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 747743 INFO (OverseerThreadFactory-2673-thread-1) [ ] o.a.s.c.a.c.CreateCollectionCmd Create collection test_col
[junit4] 2> 747850 INFO (OverseerStateUpdate-72274892327485447-127.0.0.1:41793_solr-n_0000000000) [ ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"test_col",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"test_col_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:41793/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 747851 INFO (OverseerStateUpdate-72274892327485447-127.0.0.1:41793_solr-n_0000000000) [ ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"test_col",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"test_col_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:42979/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 747852 INFO (OverseerStateUpdate-72274892327485447-127.0.0.1:41793_solr-n_0000000000) [ ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"test_col",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"test_col_shard2_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:33309/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 747853 INFO (OverseerStateUpdate-72274892327485447-127.0.0.1:41793_solr-n_0000000000) [ ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"test_col",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"test_col_shard2_replica_n6",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:34741/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 748092 INFO (qtp1813467041-6614) [n:127.0.0.1:42979_solr x:test_col_shard1_replica_n2] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates_config-set&newCollection=true&collection=test_col&version=2&replicaType=NRT&property.schema=schema-minimal-atomic-stress.xml&property.config=solrconfig-tlog.xml&coreNodeName=core_node5&name=test_col_shard1_replica_n2&action=CREATE&numShards=2&shard=shard1&wt=javabin
[junit4] 2> 748092 INFO (qtp1813467041-6614) [n:127.0.0.1:42979_solr x:test_col_shard1_replica_n2] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 748093 INFO (qtp886172914-6635) [n:127.0.0.1:41793_solr x:test_col_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates_config-set&newCollection=true&collection=test_col&version=2&replicaType=NRT&property.schema=schema-minimal-atomic-stress.xml&property.config=solrconfig-tlog.xml&coreNodeName=core_node3&name=test_col_shard1_replica_n1&action=CREATE&numShards=2&shard=shard1&wt=javabin
[junit4] 2> 748108 INFO (qtp1557016129-6619) [n:127.0.0.1:33309_solr x:test_col_shard2_replica_n4] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates_config-set&newCollection=true&collection=test_col&version=2&replicaType=NRT&property.schema=schema-minimal-atomic-stress.xml&property.config=solrconfig-tlog.xml&coreNodeName=core_node7&name=test_col_shard2_replica_n4&action=CREATE&numShards=2&shard=shard2&wt=javabin
[junit4] 2> 748116 INFO (qtp768247097-6612) [n:127.0.0.1:34741_solr x:test_col_shard2_replica_n6] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates_config-set&newCollection=true&collection=test_col&version=2&replicaType=NRT&property.schema=schema-minimal-atomic-stress.xml&property.config=solrconfig-tlog.xml&coreNodeName=core_node8&name=test_col_shard2_replica_n6&action=CREATE&numShards=2&shard=shard2&wt=javabin
[junit4] 2> 749145 INFO (qtp1557016129-6619) [n:127.0.0.1:33309_solr c:test_col s:shard2 r:core_node7 x:test_col_shard2_replica_n4] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
[junit4] 2> 749155 INFO (qtp1557016129-6619) [n:127.0.0.1:33309_solr c:test_col s:shard2 r:core_node7 x:test_col_shard2_replica_n4] o.a.s.s.IndexSchema [test_col_shard2_replica_n4] Schema name=minimal-atomic-stress
[junit4] 2> 749157 INFO (qtp1557016129-6619) [n:127.0.0.1:33309_solr c:test_col s:shard2 r:core_node7 x:test_col_shard2_replica_n4] o.a.s.s.IndexSchema Loaded schema minimal-atomic-stress/1.6 with uniqueid field id
[junit4] 2> 749157 INFO (qtp1557016129-6619) [n:127.0.0.1:33309_solr c:test_col s:shard2 r:core_node7 x:test_col_shard2_replica_n4] o.a.s.c.CoreContainer Creating SolrCore 'test_col_shard2_replica_n4' using configuration from collection test_col, trusted=true
[junit4] 2> 749157 INFO (qtp1557016129-6619) [n:127.0.0.1:33309_solr c:test_col s:shard2 r:core_node7 x:test_col_shard2_replica_n4] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33309.solr.core.test_col.shard2.replica_n4' (registry 'solr.core.test_col.shard2.replica_n4') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70dc7a82
[junit4] 2> 749157 INFO (qtp1557016129-6619) [n:127.0.0.1:33309_solr c:test_col s:shard2 r:core_node7 x:test_col_shard2_replica_n4] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 749157 INFO (qtp1557016129-6619) [n:127.0.0.1:33309_solr c:test_col s:shard2 r:core_node7 x:test_col_shard2_replica_n4] o.a.s.c.SolrCore [[test_col_shard2_replica_n4] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestStressCloudBlindAtomicUpdates_F50D49E115673B5A-001/tempDir-001/node2/test_col_shard2_replica_n4], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestStressCloudBlindAtomicUpdates_F50D49E115673B5A-001/tempDir-001/node2/./test_col_shard2_replica_n4/data/]
[junit4] 2> 749160 INFO (qtp1557016129-6619) [n:127.0.0.1:33309_solr c:test_col s:shard2 r:core_node7 x:test_col_shard2_replica_n4] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=43, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6470410918418976]
[junit4] 2> 749162 WARN (qtp1557016129-6619) [n:127.0.0.1:33309_solr c:test_col s:shard2 r:core_node7 x:test_col_shard2_replica_n4] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 749167 INFO (qtp886172914-6635) [n:127.0.0.1:41793_solr c:test_col s:shard1 r:core_node3 x:test_col_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
[junit4] 2> 749167 INFO (qtp1813467041-6614) [n:127.0.0.1:42979_solr c:test_col s:shard1 r:core_node5 x:test_col_shard1_replica_n2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
[junit4] 2> 749173 INFO (qtp768247097-6612) [n:127.0.0.1:34741_solr c:test_col s:shard2 r:core_node8 x:test_col_shard2_replica_n6] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.5.0
[junit4] 2> 749204 INFO (qtp886172914-6635) [n:127.0.0.1:41793_solr c:test_col s:shard1 r:core_node3 x:test_col_shard1_replica_n1] o.a.s.s.IndexSchema [test_col_shard1_replica_n1] Schema name=minimal-atomic-stress
[junit4] 2> 749204 INFO (qtp768247097-6612) [n:127.0.0.1:34741_solr c:test_col s:shard2 r:core_node8 x:test_col_shard2_replica_n6] o.a.s.s.IndexSchema [test_col_shard2_replica_n6] Schema name=minimal-atomic-stress
[junit4] 2> 749205 INFO (qtp886172914-6635) [n:127.0.0.1:41793_solr c:test_col s:shard1 r:core_node3 x:test_col_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal-atomic-stress/1.6 with uniqueid field id
[junit4] 2> 749205 INFO (qtp768247097-6612) [n:127.0.0.1:34741_solr c:test_col s:shard2 r:core_node8 x:test_col_shard2_replica_n6] o.a.s.s.IndexSchema Loaded schema minimal-atomic-stress/1.6 with uniqueid field id
[junit4] 2> 749205 INFO (qtp886172914-6635) [n:127.0.0.1:41793_solr c:test_col s:shard1 r:core_node3 x:test_col_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'test_col_shard1_replica_n1' using configuration from collection test_col, trusted=true
[junit4] 2> 749205 INFO (qtp768247097-6612) [n:127.0.0.1:34741_solr c:test_col s:shard2 r:core_node8 x:test_col_shard2_replica_n6] o.a.s.c.CoreContainer Creating SolrCore 'test_col_shard2_replica_n6' using configuration from collection test_col, trusted=true
[junit4] 2> 749206 INFO (qtp768247097-6612) [n:127.0.0.1:34741_solr c:test_col s:shard2 r:core_node8 x:test_col_shard2_replica_n6] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34741.solr.core.test_col.shard2.replica_n6' (registry 'solr.core.test_col.shard2.replica_n6') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70dc7a82
[junit4] 2> 749206 INFO (qtp768247097-6612) [n:127.0.0.1:34741_solr c:test_col s:shard2 r:core_node8 x:test_col_shard2_replica_n6] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 749206 INFO (qtp768247097-6612) [n:127.0.0.1:34741_solr c:test_col s:shard2 r:core_node8 x:test_col_shard2_replica_n6] o.a.s.c.SolrCore [[test_col_shard2_replica_n6] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestStressCloudBlindAtomicUpdates_F50D49E115673B5A-001/tempDir-001/node4/test_col_shard2_replica_n6], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestStressCloudBlindAtomicUpdates_F50D49E115673B5A-001/tempDir-001/node4/./test_col_shard2_replica_n6/data/]
[junit4] 2> 749206 INFO (qtp886172914-6635) [n:127.0.0.1:41793_solr c:test_col s:shard1 r:core_node3 x:test_col_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41793.solr.core.test_col.shard1.replica_n1' (registry 'solr.core.test_col.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70dc7a82
[junit4] 2> 749208 INFO (qtp886172914-6635) [n:127.0.0.1:41793_solr c:test_col s:shard1 r:core_node3 x:test_col_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 749209 INFO (qtp886172914-6635) [n:127.0.0.1:41793_solr c:test_col s:shard1 r:core_node3 x:test_col_shard1_replica_n1] o.a.s.c.SolrCore [[test_col_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestStressCloudBlindAtomicUpdates_F50D49E115673B5A-001/tempDir-001/node3/test_col_shard1_replica_n1], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestStressCloudBlindAtomicUpdates_F50D49E115673B5A-001/tempDir-001/node3/./test_col_shard1_replica_n1/data/]
[junit4] 2> 749211 INFO (qtp768247097-6612) [n:127.0.0.1:34741_solr c:test_col s:shard2 r:core_node8 x:test_col_shard2_replica_n6] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=43, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6470410918418976]
[junit4] 2> 749212 INFO (qtp886172914-6635) [n:127.0.0.1:41793_solr c:test_col s:shard1 r:core_node3 x:test_col_shard1_replica_n1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=43, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6470410918418976]
[junit4] 2> 749212 INFO (qtp1813467041-6614) [n:127.0.0.1:42979_solr c:test_col s:shard1 r:core_node5 x:test_col_shard1_replica_n2] o.a.s.s.IndexSchema [test_col_shard1_replica_n2] Schema name=minimal-atomic-stress
[junit4] 2> 749213 INFO (qtp1813467041-6614) [n:127.0.0.1:42979_solr c:test_col s:shard1 r:core_node5 x:test_col_shard1_replica_n2] o.a.s.s.IndexSchema Loaded schema minimal-atomic-stress/1.6 with uniqueid field id
[junit4] 2> 749213 INFO (qtp1813467041-6614) [n:127.0.0.1:42979_solr c:test_col s:shard1 r:core_node5 x:test_col_shard1_replica_n2] o.a.s.c.CoreContainer Creating SolrCore 'test_col_shard1_replica_n2' using configuration from collection test_col, trusted=true
[junit4] 2> 749214 INFO (qtp1813467041-6614) [n:127.0.0.1:42979_solr c:test_col s:shard1 r:core_node5 x:test_col_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42979.solr.core.test_col.shard1.replica_n2' (registry 'solr.core.test_col.shard1.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70dc7a82
[junit4] 2> 749214 INFO (qtp1813467041-6614) [n:127.0.0.1:42979_solr c:test_col s:shard1 r:core_node5 x:test_col_shard1_replica_n2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 749214 INFO (qtp1813467041-6614) [n:127.0.0.1:42979_solr c:test_col s:shard1 r:core_node5 x:test_col_shard1_replica_n2] o.a.s.c.SolrCore [[test_col_shard1_replica_n2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestStressCloudBlindAtomicUpdates_F50D49E115673B5A-001/tempDir-001/node1/test_col_shard1_replica_n2], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestStressCloudBlindAtomicUpdates_F50D49E115673B5A-001/tempDir-001/node1/./test_col_shard1_replica_n2/data/]
[junit4] 2> 749215 INFO (qtp1813467041-6614) [n:127.0.0.1:42979_solr c:test_col s:shard1 r:core_node5 x:test_col_shard1_replica_n2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=43, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6470410918418976]
[junit4] 2> 749220 WARN (qtp768247097-6612) [n:127.0.0.1:34741_solr c:test_col s:shard2 r:core_node8 x:test_col_shard2_replica_n6] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 749238 WARN (qtp1813467041-6614) [n:127.0.0.1:42979_solr c:test_col s:shard1 r:core_node5 x:test_col_shard1_replica_n2] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 749273 WARN (qtp886172914-6635) [n:127.0.0.1:41793_solr c:test_col s:shard1 r:core_node3 x:test_col_shard1_replica_n1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 749284 INFO (qtp1557016129-6619) [n:127.0.0.1:33309_solr c:test_col s:shard2 r:core_node7 x:test_col_shard2_replica_n4] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 749284 INFO (qtp1557016129-6619) [n:127.0.0.1:33309_solr c:test_col s:shard2 r:core_node7 x:test_col_shard2_replica_n4] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 749717 INFO (qtp1557016129-6619) [n:127.0.0.1:33309_solr c:test_col s:shard2 r:core_node7 x:test_col_shard2_replica_n4] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 749717 INFO (qtp1557016129-6619) [n:127.0.0.1:33309_solr c:test_col s:shard2 r:core_node7 x:test_col_shard2_replica_n4] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 749736 INFO (qtp1557016129-6619) [n:127.0.0.1:33309_solr c:test_col s:shard2 r:core_node7 x:test_col_shard2_replica_n4] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=41, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=41.63671875, floorSegmentMB=0.962890625, forceMergeDeletesPctAllowed=19.860997858575494, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7697680741380183, reclaimDeletesWeight=3.5378200973472054
[junit4] 2> 749736 INFO (qtp1557016129-6619) [n:127.0.0.1:33309_solr c:test_col s:shard2 r:core_node7 x:test_col_shard2_replica_n4] o.a.s.s.SolrIndexSearcher Opening [Searcher@2cb5aa66[test_col_shard2_replica_n4] main]
[junit4] 2> 749737 INFO (qtp1557016129-6619) [n:127.0.0.1:33309_solr c:test_col s:shard2 r:core_node7 x:test_col_shard2_replica_n4] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates_config-set
[junit4] 2> 749737 INFO (qtp1557016129-6619) [n:127.0.0.1:33309_solr c:test_col s:shard2 r:core_node7 x:test_col_shard2_replica_n4] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates_config-set
[junit4] 2> 749738 INFO (qtp1557016129-6619) [n:127.0.0.1:33309_solr c:test_col s:shard2 r:core_node7 x:test_col_shard2_replica_n4] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 749739 INFO (searcherExecutor-2689-thread-1-processing-n:127.0.0.1:33309_solr x:test_col_shard2_replica_n4 c:test_col s:shard2 r:core_node7) [n:127.0.0.1:33309_solr c:test_col s:shard2 r:core_node7 x:test_col_shard2_replica_n4] o.a.s.c.SolrCore [test_col_shard2_replica_n4] Registered new searcher Searcher@2cb5aa66[test_col_shard2_replica_n4] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 749739 INFO (qtp1557016129-6619) [n:127.0.0.1:33309_solr c:test_col s:shard2 r:core_node7 x:test_col_shard2_replica_n4] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1604462418550849536
[junit4] 2> 749745 INFO (qtp1557016129-6619) [n:127.0.0.1:33309_solr c:test_col s:shard2 r:core_node7 x:test_col_shard2_replica_n4] o.a.s.c.ZkShardTerms Successful update of terms at /collections/test_col/terms/shard2 to Terms{values={core_node7=0}, version=0}
[junit4] 2> 749748 INFO (qtp1557016129-6619) [n:127.0.0.1:33309_solr c:test_col s:shard2 r:core_node7 x:test_col_shard2_replica_n4] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard2: total=2 found=1 timeoutin=9999ms
[j
[...truncated too long message...]
:42847_solr c:test_col s:shard2 r:core_node6 x:test_col_shard2_replica_n5] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.test_col.shard2.leader, tag=e637aa4
[junit4] 2> 229649 INFO (coreCloseExecutor-69-thread-1) [n:127.0.0.1:42847_solr c:test_col s:shard2 r:core_node6 x:test_col_shard2_replica_n5] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 229649 INFO (coreCloseExecutor-69-thread-1) [n:127.0.0.1:42847_solr c:test_col s:shard2 r:core_node6 x:test_col_shard2_replica_n5] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1d1b22bc commitCommandVersion:0
[junit4] 2> 229659 INFO (coreCloseExecutor-70-thread-1) [n:127.0.0.1:33875_solr c:test_col s:shard2 r:core_node8 x:test_col_shard2_replica_n7] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@50f987f7: rootName = solr_33875, domain = solr.core.test_col.shard2.replica_n7, service url = null, agent id = null] for registry solr.core.test_col.shard2.replica_n7 / com.codahale.metrics.MetricRegistry@7d257079
[junit4] 2> 229660 INFO (coreCloseExecutor-71-thread-1) [n:127.0.0.1:45427_solr c:test_col s:shard1 r:core_node4 x:test_col_shard1_replica_n3] o.a.s.c.SolrCore [test_col_shard1_replica_n3] CLOSING SolrCore org.apache.solr.core.SolrCore@3918c6a3
[junit4] 2> 229668 INFO (coreCloseExecutor-71-thread-1) [n:127.0.0.1:45427_solr c:test_col s:shard1 r:core_node4 x:test_col_shard1_replica_n3] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.test_col.shard1.replica_n3, tag=3918c6a3
[junit4] 2> 229668 INFO (coreCloseExecutor-71-thread-1) [n:127.0.0.1:45427_solr c:test_col s:shard1 r:core_node4 x:test_col_shard1_replica_n3] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@79dedd5c: rootName = solr_45427, domain = solr.core.test_col.shard1.replica_n3, service url = null, agent id = null] for registry solr.core.test_col.shard1.replica_n3 / com.codahale.metrics.MetricRegistry@cae928a
[junit4] 2> 229669 INFO (jetty-closer-2-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@414ed860{/solr,null,UNAVAILABLE}
[junit4] 2> 229669 INFO (jetty-closer-2-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 229676 INFO (jetty-closer-2-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@53814a78{/solr,null,UNAVAILABLE}
[junit4] 2> 229676 INFO (jetty-closer-2-thread-2) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 229676 INFO (coreCloseExecutor-71-thread-1) [n:127.0.0.1:45427_solr c:test_col s:shard1 r:core_node4 x:test_col_shard1_replica_n3] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.test_col.shard1.leader, tag=3918c6a3
[junit4] 2> 229677 INFO (coreCloseExecutor-71-thread-1) [n:127.0.0.1:45427_solr c:test_col s:shard1 r:core_node4 x:test_col_shard1_replica_n3] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 229677 INFO (coreCloseExecutor-71-thread-1) [n:127.0.0.1:45427_solr c:test_col s:shard1 r:core_node4 x:test_col_shard1_replica_n3] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@24e29b23 commitCommandVersion:0
[junit4] 2> 229681 INFO (coreCloseExecutor-70-thread-1) [n:127.0.0.1:33875_solr c:test_col s:shard2 r:core_node8 x:test_col_shard2_replica_n7] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.test_col.shard2.leader, tag=6e6b1ef7
[junit4] 2> 229682 INFO (coreCloseExecutor-70-thread-1) [n:127.0.0.1:33875_solr c:test_col s:shard2 r:core_node8 x:test_col_shard2_replica_n7] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 229682 INFO (coreCloseExecutor-70-thread-1) [n:127.0.0.1:33875_solr c:test_col s:shard2 r:core_node8 x:test_col_shard2_replica_n7] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@61c08f15 commitCommandVersion:0
[junit4] 2> 229688 INFO (jetty-closer-2-thread-4) [ ] o.a.s.c.Overseer Overseer (id=72275010931130377-127.0.0.1:45427_solr-n_0000000000) closing
[junit4] 2> 229688 INFO (OverseerStateUpdate-72275010931130377-127.0.0.1:45427_solr-n_0000000000) [ ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:45427_solr
[junit4] 2> 229688 WARN (OverseerAutoScalingTriggerThread-72275010931130377-127.0.0.1:45427_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 229691 INFO (zkCallback-33-thread-2) [ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:33875_solr
[junit4] 2> 229694 INFO (jetty-closer-2-thread-4) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@571e602{/solr,null,UNAVAILABLE}
[junit4] 2> 229694 INFO (jetty-closer-2-thread-4) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 231193 INFO (jetty-closer-2-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@6b865125{/solr,null,UNAVAILABLE}
[junit4] 2> 231194 INFO (jetty-closer-2-thread-3) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 231194 ERROR (SUITE-TestStressCloudBlindAtomicUpdates-seed#[F50D49E115673B5A]-worker) [ ] 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> 231195 INFO (SUITE-TestStressCloudBlindAtomicUpdates-seed#[F50D49E115673B5A]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:33787 33787
[junit4] 2> 231977 INFO (Thread-0) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:33787 33787
[junit4] 2> 231978 WARN (Thread-0) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 87 /solr/collections/test_col/terms/shard2
[junit4] 2> 81 /solr/collections/test_col/terms/shard1
[junit4] 2> 9 /solr/aliases.json
[junit4] 2> 9 /solr/clusterprops.json
[junit4] 2> 4 /solr/configs/org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates_config-set
[junit4] 2> 4 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 9 /solr/clusterstate.json
[junit4] 2> 4 /solr/collections/test_col/state.json
[junit4] 2> 2 /solr/overseer_elect/election/72275010931130379-127.0.0.1:33875_solr-n_0000000001
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 9 /solr/live_nodes
[junit4] 2> 9 /solr/collections
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestStressCloudBlindAtomicUpdates_F50D49E115673B5A-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {id=PostingsFormat(name=LuceneVarGapFixedInterval)}, docValues:{_version_=DocValuesFormat(name=Asserting), long_dv_idx=DocValuesFormat(name=Direct), long_dv_stored=DocValuesFormat(name=Lucene70), id=DocValuesFormat(name=Direct), long_dv=DocValuesFormat(name=Lucene70), long_dv_stored_idx=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=1520, maxMBSortInHeap=6.7195060888256055, sim=RandomSimilarity(queryNorm=true): {}, locale=en-CA, timezone=America/Boise
[junit4] 2> NOTE: Linux 4.13.0-41-generic amd64/Oracle Corporation 10.0.1 (64-bit)/cpus=8,threads=1,free=293858192,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestStressCloudBlindAtomicUpdates]
[junit4] Completed [10/10 (4!)] on J0 in 231.08s, 5 tests, 1 failure <<< FAILURES!
[...truncated 14 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/common-build.xml:1568: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/common-build.xml:1092: There were test failures: 10 suites, 55 tests, 8 suite-level errors, 2 failures [seed: F50D49E115673B5A]
Total time: 3 minutes 56 seconds
[repro] Setting last failure code to 256
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.cloud.TestSolrCloudWithDelegationTokens
[repro] 4/5 failed: org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates
[repro] Exiting with code 256
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all warnings.
<Git Blamer> GIT_COMMIT=cfaa2b01f79e87fb26e0a3cb94be8ad406e1d12b, workspace=/var/lib/jenkins/workspace/Lucene-Solr-7.x-Linux
[WARNINGS] Computing warning deltas based on reference build #2208
Recording test results
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2