Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Solaris/1291/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC
3 tests failed.
FAILED: org.apache.solr.cloud.CollectionsAPISolrJTest.testSplitShard
Error Message:
Expected 5 slices to be active null Last available state:
DocCollection(solrj_test_splitshard//collections/solrj_test_splitshard/state.json/26)={
"replicationFactor":"1", "shards":{ "shard1":{
"range":"80000000-ffffffff", "state":"inactive",
"replicas":{"core_node1":{
"core":"solrj_test_splitshard_shard1_replica1",
"base_url":"http://127.0.0.1:62410/solr";,
"node_name":"127.0.0.1:62410_solr", "state":"active",
"leader":"true"}}}, "shard2":{ "range":"0-7fffffff",
"state":"active", "replicas":{"core_node2":{
"core":"solrj_test_splitshard_shard2_replica1",
"base_url":"http://127.0.0.1:55655/solr";,
"node_name":"127.0.0.1:55655_solr", "state":"active",
"leader":"true"}}}, "shard1_0":{ "range":"80000000-95ddffff",
"state":"active", "replicas":{"core_node3":{
"core":"solrj_test_splitshard_shard1_0_replica1",
"base_url":"http://127.0.0.1:62410/solr";,
"node_name":"127.0.0.1:62410_solr", "state":"active",
"leader":"true"}}}, "shard1_1":{ "range":"95de0000-95deffff",
"state":"active", "replicas":{"core_node4":{
"core":"solrj_test_splitshard_shard1_1_replica1",
"base_url":"http://127.0.0.1:62410/solr";,
"node_name":"127.0.0.1:62410_solr", "state":"active",
"leader":"true"}}}, "shard1_2":{ "range":"95df0000-ffffffff",
"state":"active", "replicas":{"core_node5":{
"core":"solrj_test_splitshard_shard1_2_replica1",
"base_url":"http://127.0.0.1:62410/solr";,
"node_name":"127.0.0.1:62410_solr", "state":"active",
"leader":"true"}}}}, "router":{"name":"compositeId"},
"maxShardsPerNode":"1", "autoAddReplicas":"false", "realtimeReplicas":"-1"}
Stack Trace:
java.lang.AssertionError: Expected 5 slices to be active
null
Last available state:
DocCollection(solrj_test_splitshard//collections/solrj_test_splitshard/state.json/26)={
"replicationFactor":"1",
"shards":{
"shard1":{
"range":"80000000-ffffffff",
"state":"inactive",
"replicas":{"core_node1":{
"core":"solrj_test_splitshard_shard1_replica1",
"base_url":"http://127.0.0.1:62410/solr";,
"node_name":"127.0.0.1:62410_solr",
"state":"active",
"leader":"true"}}},
"shard2":{
"range":"0-7fffffff",
"state":"active",
"replicas":{"core_node2":{
"core":"solrj_test_splitshard_shard2_replica1",
"base_url":"http://127.0.0.1:55655/solr";,
"node_name":"127.0.0.1:55655_solr",
"state":"active",
"leader":"true"}}},
"shard1_0":{
"range":"80000000-95ddffff",
"state":"active",
"replicas":{"core_node3":{
"core":"solrj_test_splitshard_shard1_0_replica1",
"base_url":"http://127.0.0.1:62410/solr";,
"node_name":"127.0.0.1:62410_solr",
"state":"active",
"leader":"true"}}},
"shard1_1":{
"range":"95de0000-95deffff",
"state":"active",
"replicas":{"core_node4":{
"core":"solrj_test_splitshard_shard1_1_replica1",
"base_url":"http://127.0.0.1:62410/solr";,
"node_name":"127.0.0.1:62410_solr",
"state":"active",
"leader":"true"}}},
"shard1_2":{
"range":"95df0000-ffffffff",
"state":"active",
"replicas":{"core_node5":{
"core":"solrj_test_splitshard_shard1_2_replica1",
"base_url":"http://127.0.0.1:62410/solr";,
"node_name":"127.0.0.1:62410_solr",
"state":"active",
"leader":"true"}}}},
"router":{"name":"compositeId"},
"maxShardsPerNode":"1",
"autoAddReplicas":"false",
"realtimeReplicas":"-1"}
at
__randomizedtesting.SeedInfo.seed([B0387CE8E8915253:6B32D184F6646EEC]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.SolrCloudTestCase.waitForState(SolrCloudTestCase.java:265)
at
org.apache.solr.cloud.CollectionsAPISolrJTest.testSplitShard(CollectionsAPISolrJTest.java:198)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.update.AutoCommitTest.testMaxDocs
Error Message:
Exception during query
Stack Trace:
java.lang.RuntimeException: Exception during query
at
__randomizedtesting.SeedInfo.seed([B0387CE8E8915253:9B9AA37C47B56D9]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:896)
at
org.apache.solr.update.AutoCommitTest.testMaxDocs(AutoCommitTest.java:225)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Caused by: java.lang.RuntimeException: REQUEST FAILED:
xpath=//result[@numFound=1]
xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int
name="QTime">0</int></lst><result name="response" numFound="0"
start="0"></result>
</response>
request was:q=id:14&qt=standard&start=0&rows=20&version=2.2
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:889)
... 40 more
FAILED: org.apache.solr.update.AutoCommitTest.testMaxTime
Error Message:
Exception during query
Stack Trace:
java.lang.RuntimeException: Exception during query
at
__randomizedtesting.SeedInfo.seed([B0387CE8E8915253:2ACC010A760BCE6F]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:896)
at
org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:270)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Caused by: java.lang.RuntimeException: REQUEST FAILED:
xpath=//result[@numFound=1]
xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int
name="QTime">0</int></lst><result name="response" numFound="0"
start="0"></result>
</response>
request was:q=id:529&qt=standard&start=0&rows=20&version=2.2
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:889)
... 40 more
Build Log:
[...truncated 11119 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionsAPISolrJTest
[junit4] 2> Creating dataDir:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_B0387CE8E8915253-001/init-core-data-001
[junit4] 2> 123095 INFO
(SUITE-CollectionsAPISolrJTest-seed#[B0387CE8E8915253]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields
[junit4] 2> 123096 INFO
(SUITE-CollectionsAPISolrJTest-seed#[B0387CE8E8915253]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 123098 INFO
(SUITE-CollectionsAPISolrJTest-seed#[B0387CE8E8915253]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_B0387CE8E8915253-001/tempDir-001
[junit4] 2> 123098 INFO
(SUITE-CollectionsAPISolrJTest-seed#[B0387CE8E8915253]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 123099 INFO (Thread-267) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 123099 INFO (Thread-267) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 123103 ERROR (Thread-267) [ ] 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> 123199 INFO
(SUITE-CollectionsAPISolrJTest-seed#[B0387CE8E8915253]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:64297
[junit4] 2> 123216 INFO (jetty-launcher-993-thread-4) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 123218 INFO (jetty-launcher-993-thread-1) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 123215 INFO (jetty-launcher-993-thread-3) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 123215 INFO (jetty-launcher-993-thread-2) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 123218 INFO (jetty-launcher-993-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@4e5f3168{/solr,null,AVAILABLE}
[junit4] 2> 123220 INFO (jetty-launcher-993-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@26e037e5{/solr,null,AVAILABLE}
[junit4] 2> 123282 INFO (jetty-launcher-993-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@75371796{/solr,null,AVAILABLE}
[junit4] 2> 123288 INFO (jetty-launcher-993-thread-3) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@2fffe7f7{HTTP/1.1,[http/1.1]}{127.0.0.1:55655}
[junit4] 2> 123289 INFO (jetty-launcher-993-thread-3) [ ]
o.e.j.s.Server Started @125687ms
[junit4] 2> 123289 INFO (jetty-launcher-993-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7b807403{/solr,null,AVAILABLE}
[junit4] 2> 123288 INFO (jetty-launcher-993-thread-1) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@28f79e1e{HTTP/1.1,[http/1.1]}{127.0.0.1:62410}
[junit4] 2> 123289 INFO (jetty-launcher-993-thread-1) [ ]
o.e.j.s.Server Started @125688ms
[junit4] 2> 123290 INFO (jetty-launcher-993-thread-2) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@43444e2{HTTP/1.1,[http/1.1]}{127.0.0.1:47612}
[junit4] 2> 123290 INFO (jetty-launcher-993-thread-2) [ ]
o.e.j.s.Server Started @125688ms
[junit4] 2> 123289 INFO (jetty-launcher-993-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=62410}
[junit4] 2> 123290 INFO (jetty-launcher-993-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=47612}
[junit4] 2> 123291 ERROR (jetty-launcher-993-thread-2) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 123291 INFO (jetty-launcher-993-thread-4) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@19d867bd{HTTP/1.1,[http/1.1]}{127.0.0.1:50092}
[junit4] 2> 123291 INFO (jetty-launcher-993-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.0.0
[junit4] 2> 123291 INFO (jetty-launcher-993-thread-4) [ ]
o.e.j.s.Server Started @125689ms
[junit4] 2> 123291 INFO (jetty-launcher-993-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=50092}
[junit4] 2> 123295 INFO (jetty-launcher-993-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 123295 INFO (jetty-launcher-993-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 123295 INFO (jetty-launcher-993-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-05-08T06:13:16.466Z
[junit4] 2> 123289 INFO (jetty-launcher-993-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=55655}
[junit4] 2> 123296 ERROR (jetty-launcher-993-thread-3) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 123291 ERROR (jetty-launcher-993-thread-1) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 123291 ERROR (jetty-launcher-993-thread-4) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 123296 INFO (jetty-launcher-993-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.0.0
[junit4] 2> 123313 INFO (jetty-launcher-993-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 123298 INFO (jetty-launcher-993-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.0.0
[junit4] 2> 123313 INFO (jetty-launcher-993-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 123313 INFO (jetty-launcher-993-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 123314 INFO (jetty-launcher-993-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 123314 INFO (jetty-launcher-993-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-05-08T06:13:16.484Z
[junit4] 2> 123314 INFO (jetty-launcher-993-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-05-08T06:13:16.485Z
[junit4] 2> 123298 INFO (jetty-launcher-993-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.0.0
[junit4] 2> 123314 INFO (jetty-launcher-993-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 123314 INFO (jetty-launcher-993-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 123314 INFO (jetty-launcher-993-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-05-08T06:13:16.485Z
[junit4] 2> 123332 INFO (jetty-launcher-993-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 123332 INFO (jetty-launcher-993-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 123339 INFO (jetty-launcher-993-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 123339 INFO (jetty-launcher-993-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 123349 INFO (jetty-launcher-993-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:64297/solr
[junit4] 2> 123367 INFO (jetty-launcher-993-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:64297/solr
[junit4] 2> 123368 INFO (jetty-launcher-993-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:64297/solr
[junit4] 2> 123375 INFO (jetty-launcher-993-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:64297/solr
[junit4] 2> 123385 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15be6b0c5700006, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 123388 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15be6b0c5700008, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 123437 INFO (jetty-launcher-993-thread-1)
[n:127.0.0.1:62410_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 123443 INFO (jetty-launcher-993-thread-3)
[n:127.0.0.1:55655_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 123465 INFO (jetty-launcher-993-thread-1)
[n:127.0.0.1:62410_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:62410_solr
[junit4] 2> 123467 INFO (jetty-launcher-993-thread-1)
[n:127.0.0.1:62410_solr ] o.a.s.c.Overseer Overseer
(id=97925463819681802-127.0.0.1:62410_solr-n_0000000000) starting
[junit4] 2> 123475 INFO (jetty-launcher-993-thread-1)
[n:127.0.0.1:62410_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:62410_solr
[junit4] 2> 123515 INFO
(zkCallback-1008-thread-1-processing-n:127.0.0.1:55655_solr)
[n:127.0.0.1:55655_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 123541 INFO
(zkCallback-1013-thread-1-processing-n:127.0.0.1:62410_solr)
[n:127.0.0.1:62410_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 123566 INFO (jetty-launcher-993-thread-3)
[n:127.0.0.1:55655_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:55655_solr
[junit4] 2> 123571 INFO (jetty-launcher-993-thread-2)
[n:127.0.0.1:47612_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 123572 INFO (jetty-launcher-993-thread-4)
[n:127.0.0.1:50092_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 123576 INFO (jetty-launcher-993-thread-2)
[n:127.0.0.1:47612_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 123577 INFO (jetty-launcher-993-thread-4)
[n:127.0.0.1:50092_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 123577 INFO
(zkCallback-1015-thread-1-processing-n:127.0.0.1:50092_solr)
[n:127.0.0.1:50092_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 123586 INFO
(zkCallback-1014-thread-1-processing-n:127.0.0.1:47612_solr)
[n:127.0.0.1:47612_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 123588 INFO (jetty-launcher-993-thread-4)
[n:127.0.0.1:50092_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:50092_solr
[junit4] 2> 123588 INFO
(zkCallback-1013-thread-1-processing-n:127.0.0.1:62410_solr)
[n:127.0.0.1:62410_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 123589 INFO (jetty-launcher-993-thread-2)
[n:127.0.0.1:47612_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:47612_solr
[junit4] 2> 123589 INFO
(zkCallback-1014-thread-1-processing-n:127.0.0.1:47612_solr)
[n:127.0.0.1:47612_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 123590 INFO
(zkCallback-1008-thread-1-processing-n:127.0.0.1:55655_solr)
[n:127.0.0.1:55655_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 123590 INFO
(zkCallback-1008-thread-2-processing-n:127.0.0.1:55655_solr)
[n:127.0.0.1:55655_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (4)
[junit4] 2> 123590 INFO
(zkCallback-1014-thread-1-processing-n:127.0.0.1:47612_solr)
[n:127.0.0.1:47612_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 123591 INFO
(zkCallback-1015-thread-1-processing-n:127.0.0.1:50092_solr)
[n:127.0.0.1:50092_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 123594 INFO
(zkCallback-1013-thread-2-processing-n:127.0.0.1:62410_solr)
[n:127.0.0.1:62410_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (4)
[junit4] 2> 123597 INFO
(zkCallback-1015-thread-1-processing-n:127.0.0.1:50092_solr)
[n:127.0.0.1:50092_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 123679 INFO (jetty-launcher-993-thread-3)
[n:127.0.0.1:55655_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_55655.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@49d60fc6
[junit4] 2> 123715 INFO (jetty-launcher-993-thread-3)
[n:127.0.0.1:55655_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_55655.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@49d60fc6
[junit4] 2> 123715 INFO (jetty-launcher-993-thread-3)
[n:127.0.0.1:55655_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_55655.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@49d60fc6
[junit4] 2> 123716 INFO (jetty-launcher-993-thread-3)
[n:127.0.0.1:55655_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_B0387CE8E8915253-001/tempDir-001/node3/.
[junit4] 2> 123771 INFO (jetty-launcher-993-thread-4)
[n:127.0.0.1:50092_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_50092.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@49d60fc6
[junit4] 2> 123775 INFO (jetty-launcher-993-thread-2)
[n:127.0.0.1:47612_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_47612.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@49d60fc6
[junit4] 2> 123783 INFO (jetty-launcher-993-thread-4)
[n:127.0.0.1:50092_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_50092.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@49d60fc6
[junit4] 2> 123783 INFO (jetty-launcher-993-thread-4)
[n:127.0.0.1:50092_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_50092.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@49d60fc6
[junit4] 2> 123785 INFO (jetty-launcher-993-thread-4)
[n:127.0.0.1:50092_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_B0387CE8E8915253-001/tempDir-001/node4/.
[junit4] 2> 123788 INFO (jetty-launcher-993-thread-2)
[n:127.0.0.1:47612_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_47612.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@49d60fc6
[junit4] 2> 123788 INFO (jetty-launcher-993-thread-2)
[n:127.0.0.1:47612_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_47612.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@49d60fc6
[junit4] 2> 123788 INFO (jetty-launcher-993-thread-2)
[n:127.0.0.1:47612_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_B0387CE8E8915253-001/tempDir-001/node2/.
[junit4] 2> 123876 INFO (jetty-launcher-993-thread-1)
[n:127.0.0.1:62410_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_62410.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@49d60fc6
[junit4] 2> 123891 INFO (jetty-launcher-993-thread-1)
[n:127.0.0.1:62410_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_62410.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@49d60fc6
[junit4] 2> 123891 INFO (jetty-launcher-993-thread-1)
[n:127.0.0.1:62410_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_62410.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@49d60fc6
[junit4] 2> 123892 INFO (jetty-launcher-993-thread-1)
[n:127.0.0.1:62410_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_B0387CE8E8915253-001/tempDir-001/node1/.
[junit4] 2> 123953 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15be6b0c570000d, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 123962 INFO
(SUITE-CollectionsAPISolrJTest-seed#[B0387CE8E8915253]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 123964 INFO
(SUITE-CollectionsAPISolrJTest-seed#[B0387CE8E8915253]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:64297/solr ready
[junit4] 2> 124062 INFO
(TEST-CollectionsAPISolrJTest.testClusterProp-seed#[B0387CE8E8915253]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testClusterProp
[junit4] 2> 124069 INFO (qtp685548671-2896) [n:127.0.0.1:47612_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterprop with params
val=false&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2 and
sendToOCPQueue=true
[junit4] 2> 124078 INFO (qtp685548671-2896) [n:127.0.0.1:47612_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={val=false&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2}
status=0 QTime=9
[junit4] 2> 124080 INFO (qtp685548671-2898) [n:127.0.0.1:47612_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterprop with params
name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 124082 INFO (qtp685548671-2898) [n:127.0.0.1:47612_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2} status=0
QTime=2
[junit4] 2> 124083 INFO
(TEST-CollectionsAPISolrJTest.testClusterProp-seed#[B0387CE8E8915253]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testClusterProp
[junit4] 2> 124111 INFO
(TEST-CollectionsAPISolrJTest.testList-seed#[B0387CE8E8915253]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testList
[junit4] 2> 124113 INFO (qtp685548671-2900) [n:127.0.0.1:47612_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params
action=LIST&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 124113 INFO (qtp685548671-2900) [n:127.0.0.1:47612_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={action=LIST&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 124114 INFO
(TEST-CollectionsAPISolrJTest.testList-seed#[B0387CE8E8915253]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testList
[junit4] 2> 124183 INFO
(TEST-CollectionsAPISolrJTest.testAddAndDeleteReplica-seed#[B0387CE8E8915253])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testAddAndDeleteReplica
[junit4] 2> 124187 INFO (qtp685548671-2899) [n:127.0.0.1:47612_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=2&collection.configName=conf&name=solrj_replicatests&action=CREATE&numShards=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 124204 INFO
(OverseerThreadFactory-717-thread-1-processing-n:127.0.0.1:62410_solr)
[n:127.0.0.1:62410_solr ] o.a.s.c.CreateCollectionCmd Create collection
solrj_replicatests
[junit4] 2> 124329 INFO (qtp685548671-2901) [n:127.0.0.1:47612_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=solrj_replicatests_shard1_replica1&action=CREATE&numShards=1&collection=solrj_replicatests&shard=shard1&wt=javabin&version=2
[junit4] 2> 124329 INFO (qtp685548671-2901) [n:127.0.0.1:47612_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 124335 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=solrj_replicatests_shard1_replica2&action=CREATE&numShards=1&collection=solrj_replicatests&shard=shard1&wt=javabin&version=2
[junit4] 2> 124337 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 124444 INFO
(zkCallback-1008-thread-2-processing-n:127.0.0.1:55655_solr)
[n:127.0.0.1:55655_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_replicatests/state.json] for collection
[solrj_replicatests] has occurred - updating... (live nodes size: [4])
[junit4] 2> 124444 INFO
(zkCallback-1014-thread-1-processing-n:127.0.0.1:47612_solr)
[n:127.0.0.1:47612_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_replicatests/state.json] for collection
[solrj_replicatests] has occurred - updating... (live nodes size: [4])
[junit4] 2> 125363 INFO (qtp685548671-2901) [n:127.0.0.1:47612_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 125363 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 125395 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.s.IndexSchema [solrj_replicatests_shard1_replica2] Schema name=minimal
[junit4] 2> 125395 INFO (qtp685548671-2901) [n:127.0.0.1:47612_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica1]
o.a.s.s.IndexSchema [solrj_replicatests_shard1_replica1] Schema name=minimal
[junit4] 2> 125401 INFO (qtp685548671-2901) [n:127.0.0.1:47612_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 125401 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 125401 INFO (qtp685548671-2901) [n:127.0.0.1:47612_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica1]
o.a.s.c.CoreContainer Creating SolrCore 'solrj_replicatests_shard1_replica1'
using configuration from collection solrj_replicatests, trusted=true
[junit4] 2> 125401 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.c.CoreContainer Creating SolrCore 'solrj_replicatests_shard1_replica2'
using configuration from collection solrj_replicatests, trusted=true
[junit4] 2> 125401 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_55655.solr.core.solrj_replicatests.shard1.replica2' (registry
'solr.core.solrj_replicatests.shard1.replica2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@49d60fc6
[junit4] 2> 125401 INFO (qtp685548671-2901) [n:127.0.0.1:47612_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_47612.solr.core.solrj_replicatests.shard1.replica1' (registry
'solr.core.solrj_replicatests.shard1.replica1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@49d60fc6
[junit4] 2> 125402 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 125402 INFO (qtp685548671-2901) [n:127.0.0.1:47612_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 125402 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.c.SolrCore [[solrj_replicatests_shard1_replica2] ] Opening new SolrCore
at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_B0387CE8E8915253-001/tempDir-001/node3/solrj_replicatests_shard1_replica2],
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_B0387CE8E8915253-001/tempDir-001/node3/./solrj_replicatests_shard1_replica2/data/]
[junit4] 2> 125402 INFO (qtp685548671-2901) [n:127.0.0.1:47612_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica1]
o.a.s.c.SolrCore [[solrj_replicatests_shard1_replica1] ] Opening new SolrCore
at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_B0387CE8E8915253-001/tempDir-001/node2/solrj_replicatests_shard1_replica1],
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_B0387CE8E8915253-001/tempDir-001/node2/./solrj_replicatests_shard1_replica1/data/]
[junit4] 2> 125510 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 125510 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 125511 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 125511 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 125512 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@632382b4[solrj_replicatests_shard1_replica2] main]
[junit4] 2> 125513 INFO (qtp685548671-2901) [n:127.0.0.1:47612_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 125513 INFO (qtp685548671-2901) [n:127.0.0.1:47612_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 125516 INFO (qtp685548671-2901) [n:127.0.0.1:47612_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 125516 INFO (qtp685548671-2901) [n:127.0.0.1:47612_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 125517 INFO (qtp685548671-2901) [n:127.0.0.1:47612_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@7077b6d9[solrj_replicatests_shard1_replica1] main]
[junit4] 2> 125519 INFO (qtp685548671-2901) [n:127.0.0.1:47612_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 125520 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 125520 INFO (qtp685548671-2901) [n:127.0.0.1:47612_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 125522 INFO (qtp685548671-2901) [n:127.0.0.1:47612_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 125522 INFO (qtp685548671-2901) [n:127.0.0.1:47612_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1566807423653511168
[junit4] 2> 125525 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 125526 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 125526 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1566807423657705472
[junit4] 2> 125529 INFO
(searcherExecutor-726-thread-1-processing-n:127.0.0.1:47612_solr
x:solrj_replicatests_shard1_replica1 s:shard1 c:solrj_replicatests)
[n:127.0.0.1:47612_solr c:solrj_replicatests s:shard1
x:solrj_replicatests_shard1_replica1] o.a.s.c.SolrCore
[solrj_replicatests_shard1_replica1] Registered new searcher
Searcher@7077b6d9[solrj_replicatests_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 125531 INFO
(searcherExecutor-727-thread-1-processing-n:127.0.0.1:55655_solr
x:solrj_replicatests_shard1_replica2 s:shard1 c:solrj_replicatests)
[n:127.0.0.1:55655_solr c:solrj_replicatests s:shard1
x:solrj_replicatests_shard1_replica2] o.a.s.c.SolrCore
[solrj_replicatests_shard1_replica2] Registered new searcher
Searcher@632382b4[solrj_replicatests_shard1_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 125544 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 125544 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 125544 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:55655/solr/solrj_replicatests_shard1_replica2/
[junit4] 2> 125544 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.u.PeerSync PeerSync: core=solrj_replicatests_shard1_replica2
url=http://127.0.0.1:55655/solr START
replicas=[http://127.0.0.1:47612/solr/solrj_replicatests_shard1_replica1/]
nUpdates=100
[junit4] 2> 125545 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.u.PeerSync PeerSync: core=solrj_replicatests_shard1_replica2
url=http://127.0.0.1:55655/solr DONE. We have no versions. sync failed.
[junit4] 2> 125549 INFO (qtp685548671-2903) [n:127.0.0.1:47612_solr
c:solrj_replicatests s:shard1 r:core_node1
x:solrj_replicatests_shard1_replica1] o.a.s.c.S.Request
[solrj_replicatests_shard1_replica1] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 125550 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the
next candidate
[junit4] 2> 125550 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we
can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 125550 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 125560 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:55655/solr/solrj_replicatests_shard1_replica2/ shard1
[junit4] 2> 125667 INFO
(zkCallback-1008-thread-2-processing-n:127.0.0.1:55655_solr)
[n:127.0.0.1:55655_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_replicatests/state.json] for collection
[solrj_replicatests] has occurred - updating... (live nodes size: [4])
[junit4] 2> 125668 INFO
(zkCallback-1014-thread-1-processing-n:127.0.0.1:47612_solr)
[n:127.0.0.1:47612_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_replicatests/state.json] for collection
[solrj_replicatests] has occurred - updating... (live nodes size: [4])
[junit4] 2> 125671 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 125675 INFO (qtp1871297482-2891) [n:127.0.0.1:55655_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica2]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=solrj_replicatests_shard1_replica2&action=CREATE&numShards=1&collection=solrj_replicatests&shard=shard1&wt=javabin&version=2}
status=0 QTime=1340
[junit4] 2> 125777 INFO
(zkCallback-1008-thread-2-processing-n:127.0.0.1:55655_solr)
[n:127.0.0.1:55655_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_replicatests/state.json] for collection
[solrj_replicatests] has occurred - updating... (live nodes size: [4])
[junit4] 2> 125777 INFO
(zkCallback-1014-thread-1-processing-n:127.0.0.1:47612_solr)
[n:127.0.0.1:47612_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_replicatests/state.json] for collection
[solrj_replicatests] has occurred - updating... (live nodes size: [4])
[junit4] 2> 126549 INFO (qtp685548671-2901) [n:127.0.0.1:47612_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=solrj_replicatests_shard1_replica1&action=CREATE&numShards=1&collection=solrj_replicatests&shard=shard1&wt=javabin&version=2}
status=0 QTime=2221
[junit4] 2> 126576 INFO (qtp685548671-2899) [n:127.0.0.1:47612_solr ]
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
30 seconds. Check all shard replicas
[junit4] 2> 126650 INFO
(zkCallback-1014-thread-1-processing-n:127.0.0.1:47612_solr)
[n:127.0.0.1:47612_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_replicatests/state.json] for collection
[solrj_replicatests] has occurred - updating... (live nodes size: [4])
[junit4] 2> 126652 INFO
(zkCallback-1008-thread-2-processing-n:127.0.0.1:55655_solr)
[n:127.0.0.1:55655_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_replicatests/state.json] for collection
[solrj_replicatests] has occurred - updating... (live nodes size: [4])
[junit4] 2> 127577 INFO (qtp685548671-2899) [n:127.0.0.1:47612_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=2&collection.configName=conf&name=solrj_replicatests&action=CREATE&numShards=1&wt=javabin&version=2}
status=0 QTime=3391
[junit4] 2> 127580 INFO (qtp685548671-2896) [n:127.0.0.1:47612_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params
node=127.0.0.1:50092_solr&action=ADDREPLICA&collection=solrj_replicatests&shard=shard1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 127584 INFO
(OverseerCollectionConfigSetProcessor-97925463819681802-127.0.0.1:62410_solr-n_0000000000)
[n:127.0.0.1:62410_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 127585 INFO
(OverseerThreadFactory-717-thread-2-processing-n:127.0.0.1:62410_solr)
[n:127.0.0.1:62410_solr ] o.a.s.c.AddReplicaCmd addReplica() : {
[junit4] 2> "collection":"solrj_replicatests",
[junit4] 2> "node":"127.0.0.1:50092_solr",
[junit4] 2> "shard":"shard1",
[junit4] 2> "operation":"addreplica"}
[junit4] 2> 127588 INFO
(OverseerThreadFactory-717-thread-2-processing-n:127.0.0.1:62410_solr)
[n:127.0.0.1:62410_solr ] o.a.s.c.AddReplicaCmd Node Identified
127.0.0.1:50092_solr for creating new replica
[junit4] 2> 127592 INFO (qtp1134067270-2871) [n:127.0.0.1:50092_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&name=solrj_replicatests_shard1_replica3&action=CREATE&collection=solrj_replicatests&shard=shard1&wt=javabin&version=2
[junit4] 2> 127593 INFO (qtp1134067270-2871) [n:127.0.0.1:50092_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 127724 INFO
(zkCallback-1008-thread-2-processing-n:127.0.0.1:55655_solr)
[n:127.0.0.1:55655_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_replicatests/state.json] for collection
[solrj_replicatests] has occurred - updating... (live nodes size: [4])
[junit4] 2> 127725 INFO
(zkCallback-1015-thread-1-processing-n:127.0.0.1:50092_solr)
[n:127.0.0.1:50092_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_replicatests/state.json] for collection
[solrj_replicatests] has occurred - updating... (live nodes size: [4])
[junit4] 2> 127725 INFO
(zkCallback-1014-thread-1-processing-n:127.0.0.1:47612_solr)
[n:127.0.0.1:47612_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_replicatests/state.json] for collection
[solrj_replicatests] has occurred - updating... (live nodes size: [4])
[junit4] 2> 128633 INFO (qtp1134067270-2871) [n:127.0.0.1:50092_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica3]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 128639 INFO (qtp1134067270-2871) [n:127.0.0.1:50092_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica3]
o.a.s.s.IndexSchema [solrj_replicatests_shard1_replica3] Schema name=minimal
[junit4] 2> 128648 INFO (qtp1134067270-2871) [n:127.0.0.1:50092_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica3]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 128648 INFO (qtp1134067270-2871) [n:127.0.0.1:50092_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica3]
o.a.s.c.CoreContainer Creating SolrCore 'solrj_replicatests_shard1_replica3'
using configuration from collection solrj_replicatests, trusted=true
[junit4] 2> 128649 INFO (qtp1134067270-2871) [n:127.0.0.1:50092_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica3]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_50092.solr.core.solrj_replicatests.shard1.replica3' (registry
'solr.core.solrj_replicatests.shard1.replica3') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@49d60fc6
[junit4] 2> 128649 INFO (qtp1134067270-2871) [n:127.0.0.1:50092_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica3]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 128649 INFO (qtp1134067270-2871) [n:127.0.0.1:50092_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica3]
o.a.s.c.SolrCore [[solrj_replicatests_shard1_replica3] ] Opening new SolrCore
at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_B0387CE8E8915253-001/tempDir-001/node4/solrj_replicatests_shard1_replica3],
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_B0387CE8E8915253-001/tempDir-001/node4/./solrj_replicatests_shard1_replica3/data/]
[junit4] 2> 128710 INFO (qtp1134067270-2871) [n:127.0.0.1:50092_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica3]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 128710 INFO (qtp1134067270-2871) [n:127.0.0.1:50092_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica3]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 128711 INFO (qtp1134067270-2871) [n:127.0.0.1:50092_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica3]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 128711 INFO (qtp1134067270-2871) [n:127.0.0.1:50092_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica3]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 128712 INFO (qtp1134067270-2871) [n:127.0.0.1:50092_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica3]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@41f50cad[solrj_replicatests_shard1_replica3] main]
[junit4] 2> 128714 INFO (qtp1134067270-2871) [n:127.0.0.1:50092_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica3]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 128715 INFO (qtp1134067270-2871) [n:127.0.0.1:50092_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica3]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 128716 INFO (qtp1134067270-2871) [n:127.0.0.1:50092_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica3]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 128716 INFO (qtp1134067270-2871) [n:127.0.0.1:50092_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica3]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1566807427002662912
[junit4] 2> 128718 INFO
(searcherExecutor-736-thread-1-processing-n:127.0.0.1:50092_solr
x:solrj_replicatests_shard1_replica3 s:shard1 c:solrj_replicatests)
[n:127.0.0.1:50092_solr c:solrj_replicatests s:shard1
x:solrj_replicatests_shard1_replica3] o.a.s.c.SolrCore
[solrj_replicatests_shard1_replica3] Registered new searcher
Searcher@41f50cad[solrj_replicatests_shard1_replica3]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 128724 INFO (qtp1134067270-2871) [n:127.0.0.1:50092_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica3]
o.a.s.c.ZkController Core needs to recover:solrj_replicatests_shard1_replica3
[junit4] 2> 128725 INFO
(updateExecutor-1009-thread-1-processing-n:127.0.0.1:50092_solr
x:solrj_replicatests_shard1_replica3 s:shard1 c:solrj_replicatests)
[n:127.0.0.1:50092_solr c:solrj_replicatests s:shard1 r:core_node3
x:solrj_replicatests_shard1_replica3] o.a.s.u.DefaultSolrCoreState Running
recovery
[junit4] 2> 128725 INFO (qtp1134067270-2871) [n:127.0.0.1:50092_solr
c:solrj_replicatests s:shard1 x:solrj_replicatests_shard1_replica3]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf&name=solrj_replicatests_shard1_replica3&action=CREATE&collection=solrj_replicatests&shard=shard1&wt=javabin&version=2}
status=0 QTime=1133
[junit4] 2> 128726 INFO
(recoveryExecutor-1011-thread-1-processing-n:127.0.0.1:50092_solr
x:solrj_replicatests_shard1_replica3 s:shard1 c:solrj_replicatests
r:core_node3) [n:127.0.0.1:50092_solr c:solrj_replicatests s:shard1
r:core_node3 x:solrj_replicatests_shard1_replica3] o.a.s.c.RecoveryStrategy
Starting recovery process. recoveringAfterStartup=true
[junit4] 2> 128726 INFO
(recoveryExecutor-1011-thread-1-processing-n:127.0.0.1:50092_solr
x:solrj_replicatests_shard1_replica3 s:shard1 c:solrj_replicatests
r:core_node3) [n:127.0.0.1:50092_solr c:solrj_replicatests s:shard1
r:core_node3 x:solrj_replicatests_shard1_replica3] o.a.s.c.RecoveryStrategy
###### startupVersions=[[]]
[junit4] 2> 128726 INFO
(recoveryExecutor-1011-thread-1-processing-n:127.0.0.1:50092_solr
x:solrj_replicatests_shard1_replica3 s:shard1 c:solrj_replicatests
r:core_node3) [n:127.0.0.1:50092_solr c:solrj_replicatests s:shard1
r:core_node3 x:solrj_replicatests_shard1_replica3] o.a.s.c.RecoveryStrategy
Begin buffering updates. core=[solrj_replicatests_shard1_replica3]
[junit4] 2> 128726 INFO
(recoveryExecutor-1011-thread-1-processing-n:127.0.0.1:50092_solr
x:solrj_replicatests_shard1_replica3 s:shard1 c:solrj_replicatests
r:core_node3) [n:127.0.0.1:50092_solr c:solrj_replicatests s:shard1
r:core_node3 x:solrj_replicatests_shard1_replica3] o.a.s.u.UpdateLog Starting
to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null}
[junit4] 2> 128726 INFO
(recoveryExecutor-1011-thread-1-processing-n:127.0.0.1:50092_solr
x:solrj_replicatests_shard1_replica3 s:shard1 c:solrj_replicatests
r:core_node3) [n:127.0.0.1:50092_solr c:solrj_replicatests s:shard1
r:core_node3 x:solrj_replicatests_shard1_replica3] o.a.s.c.RecoveryStrategy
Publishing state of core [solrj_replicatests_shard1_replica3] as recovering,
leader is [http://127.0.0.1:55655/solr/solrj_replicatests_shard1_replica2/] and
I am [http://127.0.0.1:50092/solr/solrj_replicatests_shard1_replica3/]
[junit4] 2> 128732 INFO (qtp685548671-2896) [n:127.0.0.1:47612_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={node=127.0.0.1:50092_solr&action=ADDREPLICA&collection=solrj_replicatests&shard=shard1&wt=javabin&version=2}
status=0 QTime=1152
[junit4] 2> 128733 INFO
(recoveryExecutor-1011-thread-1-processing-n:127.0.0.1:50092_solr
x:solrj_replicatests_shard1_replica3 s:shard1 c:solrj_replicatests
r:core_node3) [n:127.0.0.1:50092_solr c:solrj_replicatests s:shard1
r:core_node3 x:solrj_replicatests_shard1_replica3] o.a.s.c.RecoveryStrategy
Sending prep recovery command to [http://127.0.0.1:55655/solr]; [WaitForState:
action=PREPRECOVERY&core=solrj_replicatests_shard1_replica2&nodeName=127.0.0.1:50092_solr&coreNodeName=core_node3&state=recovering&checkLive=true&onlyIfLeader=true&onlyIfLeaderActive=true]
[junit4] 2> 128735 INFO (qtp1871297482-2894) [n:127.0.0.1:55655_solr ]
o.a.s.h.a.PrepRecoveryOp Going to wait for coreNodeName: core_node3, state:
recovering, checkLive: true, onlyIfLeader: true, onlyIfLeaderActive: true
[junit4] 2> 128736 INFO (qtp1871297482-2894) [n:127.0.0.1:55655_solr ]
o.a.s.h.a.PrepRecoveryOp Will wait a max of 183 seconds to see
solrj_replicatests_shard1_replica2 (shard1 of solrj_replicatests) have state:
recovering
[junit4] 2> 128736 INFO (qtp1871297482-2894) [n:127.0.0.1:55655_solr ]
o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering):
collection=solrj_replicatests, shard=shard1,
thisCore=solrj_replicatests_shard1_replica2, leaderDoesNotNeedRecovery=false,
isLeader? true, live=true, checkLive=true, currentState=down,
localState=active, nodeName=127.0.0.1:50092_solr, coreNodeName=core_node3,
onlyIfActiveCheckResult=false, nodeProps:
core_node3:{"core":"solrj_replicatests_shard1_replica3","base_url":"http://127.0.0.1:50092/solr","node_name":"127.0.0.1:50092_solr","state":"down"}
[junit4] 2> 128746 INFO (qtp685548671-2898) [n:127.0.0.1:47612_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :deletereplica with
params
replica=core_node3&action=DELETEREPLICA&collection=solrj_replicatests&shard=shard1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 128751 INFO
(OverseerCollectionConfigSetProcessor-97925463819681802-127.0.0.1:62410_solr-n_0000000000)
[n:127.0.0.1:62410_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 128753 INFO (qtp1134067270-2873) [n:127.0.0.1:50092_solr ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.solrj_replicatests.shard1.replica3, tag=null
[junit4] 2> 128757 WARN (qtp1134067270-2873) [n:127.0.0.1:50092_solr ]
o.a.s.c.RecoveryStrategy Stopping recovery for
core=[solrj_replicatests_shard1_replica3] coreNodeName=[core_node3]
[junit4] 2> 128760 INFO (qtp1134067270-2873) [n:127.0.0.1:50092_solr ]
o.a.s.c.SolrCore Core solrj_replicatests_shard1_replica3 is not yet closed,
waiting 100 ms before checking again.
[junit4] 2> 128763 ERROR
(recoveryExecutor-1011-thread-1-processing-n:127.0.0.1:50092_solr
x:solrj_replicatests_shard1_replica3 s:shard1 c:solrj_replicatests
r:core_node3) [n:127.0.0.1:50092_solr c:solrj_replicatests s:shard1
r:core_node3 x:solrj_replicatests_shard1_replica3] o.a.s.c.RecoveryStrategy
Error while trying to recover.
core=solrj_replicatests_shard1_replica3:java.util.concurrent.ExecutionException:
org.apache.solr.client.solrj.SolrServerException: IOException occured when
talking to server at: http://127.0.0.1:55655/solr
[junit4] 2> at
java.util.concurrent.FutureTask.report(FutureTask.java:122)
[junit4] 2> at
java.util.concurrent.FutureTask.get(FutureTask.java:192)
[junit4] 2> at
org.apache.solr.cloud.RecoveryStrategy.sendPrepRecoveryCmd(RecoveryStrategy.java:701)
[junit4] 2> at
org.apache.solr.cloud.RecoveryStrategy.sendPrepRecoveryCmd(RecoveryStrategy.java:676)
[junit4] 2> at
org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:421)
[junit4] 2> at
org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:287)
[junit4] 2> at
com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
[junit4] 2> at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at
java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> Caused by: org.apache.solr.client.solrj.SolrServerException:
IOException occured when talking to server at: http://127.0.0.1:55655/solr
[junit4] 2> at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:641)
[junit4] 2> at
org.apache.solr.client.solrj.impl.HttpSolrClient.lambda$httpUriRequest$0(HttpSolrClient.java:319)
[junit4] 2> ... 5 more
[junit4] 2> Caused by: java.net.SocketException: Socket closed
[junit4] 2> at
java.net.SocketInputStream.read(SocketInputStream.java:204)
[junit4] 2> at
java.net.SocketInputStream.read(SocketInputStream.java:141)
[junit4] 2> at
org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:139)
[junit4] 2> at
org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:155)
[junit4] 2> at
org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:284)
[junit4] 2> at
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
[junit4] 2> at
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
[junit4] 2> at
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
[junit4] 2> at
org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:165)
[junit4] 2> at
org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:167)
[junit4] 2> at
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
[junit4] 2> at
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
[junit4] 2> at
org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:271)
[junit4] 2> at
org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:184)
[junit4] 2> at
org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:88)
[junit4] 2> at
org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
[junit4] 2> at
org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:184)
[junit4] 2> at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
[junit4] 2> at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
[junit4] 2> at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:532)
[junit4] 2> ... 6 more
[junit4] 2>
[junit4] 2> 128764 INFO
(recoveryExecutor-1011-thread-1-processing-n:127.0.0.1:50092_solr
x:solrj_replicatests_shard1_replica3 s:shard1 c:solrj_replicatests
r:core_node3) [n:127.0.0.1:50092_solr c:solrj_replicatests s:shard1
r:core_node3 x:solrj_replicatests_shard1_replica3] o.a.s.c.RecoveryStrategy
Replay not started, or was not successful... still buffering updates.
[junit4] 2> 128764 INFO
(recoveryExecutor-1011-thread-1-processing-n:127.0.0.1:50092_solr
x:solrj_replicatests_shard1_replica3 s:shard1 c:solrj_replicatests
r:core_node3) [n:127.0.0.1:50092_solr c:solrj_replicatests s:shard1
r:core_node3 x:solrj_replicatests_shard1_replica3] o.a.s.c.RecoveryStrategy
RecoveryStrategy has been closed
[junit4] 2> 128764 INFO
(recoveryExecutor-1011-thread-1-processing-n:127.0.0.1:50092_solr
x:solrj_replicatests_shard1_replica3 s:shard1 c:solrj_replicatests
r:core_node3) [n:127.0.0.1:50092_solr c:solrj_replicatests s:shard1
r:core_node3 x:solrj_replicatests_shard1_replica3] o.a.s.c.RecoveryStrategy
Finished recovery process, successful=[false]
[junit4] 2> 128764 INFO
(recoveryExecutor-1011-thread-1-processing-n:127.0.0.1:50092_solr
x:solrj_replicatests_shard1_replica3 s:shard1 c:solrj_replicatests
r:core_node3) [n:127.0.0.1:50092_solr c:solrj_replicatests s:shard1
r:core_node3 x:solrj_replicatests_shard1_replica3] o.a.s.c.SolrCore
[solrj_replicatests_shard1_replica3] CLOSING SolrCore
org.apache.solr.core.SolrCore@796259bd
[junit4] 2> 128765 WARN
(recoveryExecutor-1011-thread-1-processing-n:127.0.0.1:50092_solr
x:solrj_replicatests_shard1_replica3 s:shard1 c:solrj_replicatests
r:core_node3) [n:127.0.0.1:50092_solr c:solrj_replicatests s:shard1
r:core_node3 x:solrj_replicatests_shard1_replica3] o.a.s.c.RecoveryStrategy
Stopping recovery for core=[solrj_replicatests_shard1_replica3]
coreNodeName=[core_node3]
[junit4] 2> 128766 INFO
(recoveryExecutor-1011-thread-1-processing-n:127.0.0.1:50092_solr
x:solrj_replicatests_shard1_replica3 s:shard1 c:solrj_replicatests
r:core_node3) [n:127.0.0.1:50092_solr c:solrj_replicatests s:shard1
r:core_node3 x:solrj_replicatests_shard1_replica3] o.a.s.m.SolrMetricManager
Closing metric reporters for
registry=solr.core.solrj_replicatests.shard1.replica3, tag=2036488637
[junit4] 2> 128766 INFO
(recoveryExecutor-1011-thread-1-processing-n:127.0.0.1:50092_solr
x:solrj_replicatests_shard1_replica3 s:shard1 c:solrj_replicatests
r:core_node3) [n:127.0.0.1:50092_solr c:solrj_replicatests s:shard1
r:core_node3 x:solrj_replicatests_shard1_replica3] o.a.s.m.SolrMetricManager
Closing metric reporters for
registry=solr.collection.solrj_replicatests.shard1.leader, tag=2036488637
[junit4] 2> 128834 INFO
(zkCallback-1008-thread-2-processing-n:127.0.0.1:55655_solr)
[n:127.0.0.1:55655_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_replicatests/state.json] for collection
[solrj_replicatests] has occurred - updating... (live nodes size: [4])
[junit4] 2> 128834 INFO
(zkCallback-1015-thread-1-processing-n:127.0.0.1:50092_solr)
[n:127.0.0.1:50092_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_replicatests/state.json] for collection
[solrj_replicatests] has occurred - updating... (live nodes size: [4])
[junit4] 2> 128835 INFO
(zkCallback-1014-thread-1-processing-n:127.0.0.1:47612_solr)
[n:127.0.0.1:47612_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_replicatests/state.json] for collection
[solrj_replicatests] has occurred - updating... (live nodes size: [4])
[junit4] 2> 128862 INFO (qtp1134067270-2873) [n:127.0.0.1:50092_solr ]
o.a.s.c.ShardLeaderElectionContextBase No version found for ephemeral leader
parent node, won't remove previous leader registration.
[junit4] 2> 128863 INFO (qtp1134067270-2873) [n:127.0.0.1:50092_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={deleteInstanceDir=true&core=solrj_replicatests_shard1_replica3&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2&deleteIndex=true}
status=0 QTime=111
[junit4] 2> 128970 INFO
(zkCallback-1008-thread-2-processing-n:127.0.0.1:55655_solr)
[n:127.0.0.1:55655_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_replicatests/state.json] for collection
[solrj_replicatests] has occurred - updating... (live nodes size: [4])
[junit4] 2> 128970 INFO
(zkCallback-1014-thread-1-processing-n:127.0.0.1:47612_solr)
[n:127.0.0.1:47612_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solrj_replicatests/state.json] for collection
[solrj_replicatests] has occurred - updating... (live nodes size: [4])
[junit4] 2> 129069 INFO (qtp685548671-2898) [n:127.0.0.1:47612_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replica=core_node3&action=DELETEREPLICA&collection=solrj_replicatests&shard=shard1&wt=javabin&version=2}
status=0 QTime=322
[junit4] 2> 129072 INFO
(TEST-CollectionsAPISolrJTest.testAddAndDeleteReplica-seed#[B0387CE8E8915253])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testAddAndDeleteReplica
[junit4] 2> 129117 INFO
(TEST-CollectionsAPISolrJTest.testCreateAndDeleteAlias-seed#[B0387CE8E8915253])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testCreateAndDeleteAlias
[junit4] 2> 129118 INFO (qtp685548671-2900) [n:127.0.0.1:47612_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=conf&name=aliasedCollection&action=CREATE&numShards=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 129150 INFO
(OverseerThreadFactory-717-thread-4-processing-n:127.0.0.1:62410_solr)
[n:127.0.0.1:62410_solr ] o.a.s.c.CreateCollectionCmd Create collection
aliasedCollection
[junit4] 2> 129152 INFO
(OverseerCollectionConfigSetProcessor-97925463819681802-127.0.0.1:62410_solr-n_0000000000)
[n:127.0.0.1:62410_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000004 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 129362 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=aliasedCollection_shard1_replica1&action=CREATE&numShards=1&collection=aliasedCollection&shard=shard1&wt=javabin&version=2
[junit4] 2> 129362 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 129469 INFO
(zkCallback-1013-thread-2-processing-n:127.0.0.1:62410_solr)
[n:127.0.0.1:62410_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/aliasedCollection/state.json] for collection
[aliasedCollection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 130376 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 130390 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.s.IndexSchema [aliasedCollection_shard1_replica1] Schema name=minimal
[junit4] 2> 130392 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 130392 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.c.CoreContainer Creating SolrCore 'aliasedCollection_shard1_replica1'
using configuration from collection aliasedCollection, trusted=true
[junit4] 2> 130393 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_62410.solr.core.aliasedCollection.shard1.replica1' (registry
'solr.core.aliasedCollection.shard1.replica1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@49d60fc6
[junit4] 2> 130393 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 130393 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.c.SolrCore [[aliasedCollection_shard1_replica1] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_B0387CE8E8915253-001/tempDir-001/node1/aliasedCollection_shard1_replica1],
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_B0387CE8E8915253-001/tempDir-001/node1/./aliasedCollection_shard1_replica1/data/]
[junit4] 2> 130456 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 130456 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 130457 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 130457 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 130459 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@57531a55[aliasedCollection_shard1_replica1] main]
[junit4] 2> 130461 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 130465 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 130466 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 130468 INFO
(searcherExecutor-741-thread-1-processing-n:127.0.0.1:62410_solr
x:aliasedCollection_shard1_replica1 s:shard1 c:aliasedCollection)
[n:127.0.0.1:62410_solr c:aliasedCollection s:shard1
x:aliasedCollection_shard1_replica1] o.a.s.c.SolrCore
[aliasedCollection_shard1_replica1] Registered new searcher
Searcher@57531a55[aliasedCollection_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 130480 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1566807428852350976
[junit4] 2> 130496 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 130496 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 130496 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:62410/solr/aliasedCollection_shard1_replica1/
[junit4] 2> 130496 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 130496 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.c.SyncStrategy
http://127.0.0.1:62410/solr/aliasedCollection_shard1_replica1/ has no replicas
[junit4] 2> 130496 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 130506 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:62410/solr/aliasedCollection_shard1_replica1/ shard1
[junit4] 2> 130608 INFO
(zkCallback-1013-thread-2-processing-n:127.0.0.1:62410_solr)
[n:127.0.0.1:62410_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/aliasedCollection/state.json] for collection
[aliasedCollection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 130657 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 130660 INFO (qtp1339803146-2879) [n:127.0.0.1:62410_solr
c:aliasedCollection s:shard1 x:aliasedCollection_shard1_replica1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=aliasedCollection_shard1_replica1&action=CREATE&numShards=1&collection=aliasedCollection&shard=shard1&wt=javabin&version=2}
status=0 QTime=1298
[junit4] 2> 130666 INFO (qtp685548671-2900) [n:127.0.0.1:47612_solr ]
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
30 seconds. Check all shard replicas
[junit4] 2> 130771 INFO
(zkCallback-1013-thread-2-processing-n:127.0.0.1:62410_solr)
[n:127.0.0.1:62410_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/aliasedCollection/state.json] for collection
[aliasedCollection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 131155 INFO
(OverseerCollectionConfigSetProcessor-97925463819681802-127.0.0.1:62410_solr-n_0000000000)
[n:127.0.0.1:62410_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000006 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 131667 INFO (qtp685548671-2900) [n:127.0.0.1:47612_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=1&collection.configName=conf&name=aliasedCollection&action=CREATE&numShards=1&wt=javabin&version=2}
status=0 QTime=2550
[junit4] 2> 131670 INFO (qtp685548671-2902) [n:127.0.0.1:47612_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :createalias with params
collections=aliasedCollection&name=solrj_alias&action=CREATEALIAS&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 131779 INFO (qtp685548671-2902)
[...truncated too long message...]
collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566808112203038721)]} 0 6030
[junit4] 2> 782174 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[B0387CE8E8915253]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566808112203038722)]} 0 6031
[junit4] 2> 782174 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[B0387CE8E8915253]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566808112203038723)]} 0 6031
[junit4] 2> 782174 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[B0387CE8E8915253]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566808112203038724)]} 0 6031
[junit4] 2> 782175 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[B0387CE8E8915253]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566808112204087296)]} 0 6031
[junit4] 2> 782175 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[B0387CE8E8915253]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566808112204087297)]} 0 6031
[junit4] 2> 782175 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[B0387CE8E8915253]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566808112204087298)]} 0 6031
[junit4] 2> 782175 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[B0387CE8E8915253]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1566808112204087299)]} 0 6031
[junit4] 2> 782175 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[B0387CE8E8915253]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:500&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0
QTime=0
[junit4] 2> 782176 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[B0387CE8E8915253]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1566808112204087300)]} 0 6032
[junit4] 2> 782176 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[B0387CE8E8915253]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1566808112205135872)]} 0 6032
[junit4] 2> 782176 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[B0387CE8E8915253]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1566808112205135873)]} 0 6032
[junit4] 2> 782176 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[B0387CE8E8915253]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1566808112205135874)]} 0 6032
[junit4] 2> 782176 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[B0387CE8E8915253]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1566808112205135875)]} 0 6033
[junit4] 2> 782176 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[B0387CE8E8915253]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1566808112205135876)]} 0 6033
[junit4] 2> 782177 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[B0387CE8E8915253]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1566808112205135877)]} 0 6033
[junit4] 2> 782177 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[B0387CE8E8915253]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1566808112206184448)]} 0 6033
[junit4] 2> 782177 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[B0387CE8E8915253]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1566808112206184449)]} 0 6033
[junit4] 2> 782177 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[B0387CE8E8915253]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1566808112206184450)]} 0 6033
[junit4] 2> 782177 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[B0387CE8E8915253]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0
QTime=0
[junit4] 2> 783176 INFO (commitScheduler-3238-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 783179 INFO (commitScheduler-3238-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@7709c89e[collection1] main]
[junit4] 2> 783179 INFO (commitScheduler-3238-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 783181 INFO
(searcherExecutor-3235-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@7709c89e[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):c10/9:delGen=1)))}
[junit4] 2> 783183 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[B0387CE8E8915253]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:500&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0
QTime=0
[junit4] 2> 783183 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[B0387CE8E8915253]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0
QTime=0
[junit4] 2> 783183 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[B0387CE8E8915253]) [
x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin
[junit4] 2> 783184 INFO
(SUITE-AutoCommitTest-seed#[B0387CE8E8915253]-worker) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 783184 INFO
(SUITE-AutoCommitTest-seed#[B0387CE8E8915253]-worker) [ x:collection1]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1963692318
[junit4] 2> 783184 INFO
(SUITE-AutoCommitTest-seed#[B0387CE8E8915253]-worker) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 783185 INFO
(SUITE-AutoCommitTest-seed#[B0387CE8E8915253]-worker) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 783186 INFO
(SUITE-AutoCommitTest-seed#[B0387CE8E8915253]-worker) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 783187 INFO
(SUITE-AutoCommitTest-seed#[B0387CE8E8915253]-worker) [ x:collection1]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 783187 INFO
(coreCloseExecutor-3239-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@6dfe22a6
[junit4] 2> 783187 INFO
(coreCloseExecutor-3239-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 783187 INFO
(coreCloseExecutor-3239-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@c4a0e0f commitCommandVersion:0
[junit4] 2> 783188 INFO
(coreCloseExecutor-3239-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=1845371558
[junit4] 2> NOTE: leaving temporary files on disk at:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_B0387CE8E8915253-001
[junit4] 2> NOTE: test params are: codec=Lucene70,
sim=RandomSimilarity(queryNorm=true): {}, locale=de-DE,
timezone=America/Shiprock
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_131
(64-bit)/cpus=3,threads=1,free=79097032,total=204988416
[junit4] 2> NOTE: All tests run in this JVM:
[WordBreakSolrSpellCheckerTest, TestSolrConfigHandlerCloud,
TestDistribDocBasedVersion, DateRangeFieldTest, URLClassifyProcessorTest,
TestRealTimeGet, DocExpirationUpdateProcessorFactoryTest,
ConfigureRecoveryStrategyTest, TestInPlaceUpdatesStandalone, MetricUtilsTest,
CollectionsAPISolrJTest, TestFreeTextSuggestions, SpellPossibilityIteratorTest,
TestExclusionRuleCollectionAccess, TestConfigSets, CursorMarkTest,
CdcrVersionReplicationTest, TestReloadAndDeleteDocs,
HdfsChaosMonkeyNothingIsSafeTest, SpellCheckCollatorWithCollapseTest,
DistributedQueryComponentOptimizationTest, TestFieldTypeResource,
ClassificationUpdateProcessorFactoryTest, SolrCoreMetricManagerTest,
TestRuleBasedAuthorizationPlugin, BlockCacheTest, TestTrie,
OverriddenZkACLAndCredentialsProvidersTest, TestManagedSynonymFilterFactory,
TestSolr4Spatial, RollingRestartTest, TestQuerySenderListener,
DistribJoinFromCollectionTest, PreAnalyzedFieldManagedSchemaCloudTest,
TestValueSourceCache, UpdateRequestProcessorFactoryTest, RemoteQueryErrorTest,
SubstringBytesRefFilterTest, TestAuthenticationFramework,
TestJavabinTupleStreamParser, SecurityConfHandlerTest,
OverseerModifyCollectionTest, CollectionsAPIDistributedZkTest,
TestCollectionAPI, VersionInfoTest, SignatureUpdateProcessorFactoryTest,
TestFieldCacheSort, DistributedIntervalFacetingTest,
CoreMergeIndexesAdminHandlerTest, SpellCheckCollatorTest, UpdateParamsTest,
UUIDUpdateProcessorFallbackTest, CollectionTooManyReplicasTest,
DistributedVersionInfoTest, TestIndexingPerformance, ForceLeaderTest,
TestLMDirichletSimilarityFactory, SmileWriterTest, ShowFileRequestHandlerTest,
TestReload, TestWriterPerf, TestRangeQuery, SolrGangliaReporterTest,
TestCoreDiscovery, TestDFRSimilarityFactory, HdfsLockFactoryTest,
TestBulkSchemaConcurrent, BasicZkTest, TestDocSet, CircularListTest,
SortSpecParsingTest, DirectoryFactoryTest, TestJsonFacetRefinement,
AutoCommitTest]
[junit4] Completed [208/709 (2!)] on J1 in 8.76s, 3 tests, 2 errors <<<
FAILURES!
[...truncated 45046 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
