Build: https://jenkins.thetaphi.de/job/Lucene-Solr-http2-Linux/15/
Java: 64bit/jdk1.8.0_172 -XX:-UseCompressedOops -XX:+UseG1GC
2 tests failed.
FAILED: org.apache.solr.cloud.api.collections.TestHdfsCloudBackupRestore.test
Error Message:
Node 127.0.0.1:36505_solr has 4 replicas. Expected num replicas : 3. state:
DocCollection(hdfsbackuprestore_restored//collections/hdfsbackuprestore_restored/state.json/17)={
"pullReplicas":0, "replicationFactor":1, "shards":{ "shard2":{
"range":"0-7fffffff", "state":"active", "replicas":{
"core_node62":{
"core":"hdfsbackuprestore_restored_shard2_replica_n61",
"base_url":"https://127.0.0.1:36505/solr";,
"node_name":"127.0.0.1:36505_solr", "state":"active",
"type":"NRT", "force_set_state":"false", "leader":"true"},
"core_node68":{
"core":"hdfsbackuprestore_restored_shard2_replica_t67",
"base_url":"https://127.0.0.1:36505/solr";,
"node_name":"127.0.0.1:36505_solr", "state":"active",
"type":"TLOG", "force_set_state":"false"}},
"stateTimestamp":"1543579612755003858"}, "shard1_1":{
"range":"c0000000-ffffffff", "state":"active", "replicas":{
"core_node64":{
"core":"hdfsbackuprestore_restored_shard1_1_replica_n63",
"base_url":"https://127.0.0.1:36505/solr";,
"node_name":"127.0.0.1:36505_solr", "state":"active",
"type":"NRT", "force_set_state":"false", "leader":"true"},
"core_node70":{
"core":"hdfsbackuprestore_restored_shard1_1_replica_t69",
"base_url":"https://127.0.0.1:39547/solr";,
"node_name":"127.0.0.1:39547_solr", "state":"active",
"type":"TLOG", "force_set_state":"false"}},
"stateTimestamp":"1543579612755040657"}, "shard1_0":{
"range":"80000000-bfffffff", "state":"active", "replicas":{
"core_node66":{
"core":"hdfsbackuprestore_restored_shard1_0_replica_n65",
"base_url":"https://127.0.0.1:39547/solr";,
"node_name":"127.0.0.1:39547_solr", "state":"active",
"type":"NRT", "force_set_state":"false", "leader":"true"},
"core_node72":{
"core":"hdfsbackuprestore_restored_shard1_0_replica_t71",
"base_url":"https://127.0.0.1:36505/solr";,
"node_name":"127.0.0.1:36505_solr", "state":"active",
"type":"TLOG", "force_set_state":"false"}},
"stateTimestamp":"1543579612755063729"}}, "router":{
"name":"compositeId", "field":"shard_s"}, "maxShardsPerNode":"-1",
"autoAddReplicas":"true", "nrtReplicas":1, "tlogReplicas":1}
Stack Trace:
java.lang.AssertionError: Node 127.0.0.1:36505_solr has 4 replicas. Expected
num replicas : 3. state:
DocCollection(hdfsbackuprestore_restored//collections/hdfsbackuprestore_restored/state.json/17)={
"pullReplicas":0,
"replicationFactor":1,
"shards":{
"shard2":{
"range":"0-7fffffff",
"state":"active",
"replicas":{
"core_node62":{
"core":"hdfsbackuprestore_restored_shard2_replica_n61",
"base_url":"https://127.0.0.1:36505/solr";,
"node_name":"127.0.0.1:36505_solr",
"state":"active",
"type":"NRT",
"force_set_state":"false",
"leader":"true"},
"core_node68":{
"core":"hdfsbackuprestore_restored_shard2_replica_t67",
"base_url":"https://127.0.0.1:36505/solr";,
"node_name":"127.0.0.1:36505_solr",
"state":"active",
"type":"TLOG",
"force_set_state":"false"}},
"stateTimestamp":"1543579612755003858"},
"shard1_1":{
"range":"c0000000-ffffffff",
"state":"active",
"replicas":{
"core_node64":{
"core":"hdfsbackuprestore_restored_shard1_1_replica_n63",
"base_url":"https://127.0.0.1:36505/solr";,
"node_name":"127.0.0.1:36505_solr",
"state":"active",
"type":"NRT",
"force_set_state":"false",
"leader":"true"},
"core_node70":{
"core":"hdfsbackuprestore_restored_shard1_1_replica_t69",
"base_url":"https://127.0.0.1:39547/solr";,
"node_name":"127.0.0.1:39547_solr",
"state":"active",
"type":"TLOG",
"force_set_state":"false"}},
"stateTimestamp":"1543579612755040657"},
"shard1_0":{
"range":"80000000-bfffffff",
"state":"active",
"replicas":{
"core_node66":{
"core":"hdfsbackuprestore_restored_shard1_0_replica_n65",
"base_url":"https://127.0.0.1:39547/solr";,
"node_name":"127.0.0.1:39547_solr",
"state":"active",
"type":"NRT",
"force_set_state":"false",
"leader":"true"},
"core_node72":{
"core":"hdfsbackuprestore_restored_shard1_0_replica_t71",
"base_url":"https://127.0.0.1:36505/solr";,
"node_name":"127.0.0.1:36505_solr",
"state":"active",
"type":"TLOG",
"force_set_state":"false"}},
"stateTimestamp":"1543579612755063729"}},
"router":{
"name":"compositeId",
"field":"shard_s"},
"maxShardsPerNode":"-1",
"autoAddReplicas":"true",
"nrtReplicas":1,
"tlogReplicas":1}
at
__randomizedtesting.SeedInfo.seed([FE5BD2BDD3FCC82B:760FED677D00A5D3]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.cloud.api.collections.AbstractCloudBackupRestoreTestCase.lambda$testBackupAndRestore$1(AbstractCloudBackupRestoreTestCase.java:339)
at java.util.HashMap.forEach(HashMap.java:1289)
at
org.apache.solr.cloud.api.collections.AbstractCloudBackupRestoreTestCase.testBackupAndRestore(AbstractCloudBackupRestoreTestCase.java:338)
at
org.apache.solr.cloud.api.collections.AbstractCloudBackupRestoreTestCase.test(AbstractCloudBackupRestoreTestCase.java:144)
at
org.apache.solr.cloud.api.collections.TestHdfsCloudBackupRestore.test(TestHdfsCloudBackupRestore.java:213)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:944)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED:
org.apache.solr.cloud.api.collections.TestLocalFSCloudBackupRestore.test
Error Message:
Node 127.0.0.1:38791_solr has 4 replicas. Expected num replicas : 3. state:
DocCollection(backuprestore_restored//collections/backuprestore_restored/state.json/13)={
"pullReplicas":0, "replicationFactor":1, "shards":{ "shard2":{
"range":"0-7fffffff", "state":"active", "replicas":{
"core_node62":{ "core":"backuprestore_restored_shard2_replica_n61",
"base_url":"https://127.0.0.1:38791/solr";,
"node_name":"127.0.0.1:38791_solr", "state":"active",
"type":"NRT", "force_set_state":"false", "leader":"true"},
"core_node68":{
"core":"backuprestore_restored_shard2_replica_t67",
"base_url":"https://127.0.0.1:38791/solr";,
"node_name":"127.0.0.1:38791_solr", "state":"active",
"type":"TLOG", "force_set_state":"false"}},
"stateTimestamp":"1543581130778474049"}, "shard1_1":{
"range":"c0000000-ffffffff", "state":"active", "replicas":{
"core_node64":{ "core":"backuprestore_restored_shard1_1_replica_n63",
"base_url":"https://127.0.0.1:38791/solr";,
"node_name":"127.0.0.1:38791_solr", "state":"active",
"type":"NRT", "force_set_state":"false", "leader":"true"},
"core_node70":{
"core":"backuprestore_restored_shard1_1_replica_t69",
"base_url":"https://127.0.0.1:40025/solr";,
"node_name":"127.0.0.1:40025_solr", "state":"active",
"type":"TLOG", "force_set_state":"false"}},
"stateTimestamp":"1543581130778499940"}, "shard1_0":{
"range":"80000000-bfffffff", "state":"active", "replicas":{
"core_node66":{ "core":"backuprestore_restored_shard1_0_replica_n65",
"base_url":"https://127.0.0.1:40025/solr";,
"node_name":"127.0.0.1:40025_solr", "state":"active",
"type":"NRT", "force_set_state":"false", "leader":"true"},
"core_node72":{
"core":"backuprestore_restored_shard1_0_replica_t71",
"base_url":"https://127.0.0.1:38791/solr";,
"node_name":"127.0.0.1:38791_solr", "state":"active",
"type":"TLOG", "force_set_state":"false"}},
"stateTimestamp":"1543581130778517947"}}, "router":{
"name":"compositeId", "field":"shard_s"}, "maxShardsPerNode":"-1",
"autoAddReplicas":"true", "nrtReplicas":1, "tlogReplicas":1}
Stack Trace:
java.lang.AssertionError: Node 127.0.0.1:38791_solr has 4 replicas. Expected
num replicas : 3. state:
DocCollection(backuprestore_restored//collections/backuprestore_restored/state.json/13)={
"pullReplicas":0,
"replicationFactor":1,
"shards":{
"shard2":{
"range":"0-7fffffff",
"state":"active",
"replicas":{
"core_node62":{
"core":"backuprestore_restored_shard2_replica_n61",
"base_url":"https://127.0.0.1:38791/solr";,
"node_name":"127.0.0.1:38791_solr",
"state":"active",
"type":"NRT",
"force_set_state":"false",
"leader":"true"},
"core_node68":{
"core":"backuprestore_restored_shard2_replica_t67",
"base_url":"https://127.0.0.1:38791/solr";,
"node_name":"127.0.0.1:38791_solr",
"state":"active",
"type":"TLOG",
"force_set_state":"false"}},
"stateTimestamp":"1543581130778474049"},
"shard1_1":{
"range":"c0000000-ffffffff",
"state":"active",
"replicas":{
"core_node64":{
"core":"backuprestore_restored_shard1_1_replica_n63",
"base_url":"https://127.0.0.1:38791/solr";,
"node_name":"127.0.0.1:38791_solr",
"state":"active",
"type":"NRT",
"force_set_state":"false",
"leader":"true"},
"core_node70":{
"core":"backuprestore_restored_shard1_1_replica_t69",
"base_url":"https://127.0.0.1:40025/solr";,
"node_name":"127.0.0.1:40025_solr",
"state":"active",
"type":"TLOG",
"force_set_state":"false"}},
"stateTimestamp":"1543581130778499940"},
"shard1_0":{
"range":"80000000-bfffffff",
"state":"active",
"replicas":{
"core_node66":{
"core":"backuprestore_restored_shard1_0_replica_n65",
"base_url":"https://127.0.0.1:40025/solr";,
"node_name":"127.0.0.1:40025_solr",
"state":"active",
"type":"NRT",
"force_set_state":"false",
"leader":"true"},
"core_node72":{
"core":"backuprestore_restored_shard1_0_replica_t71",
"base_url":"https://127.0.0.1:38791/solr";,
"node_name":"127.0.0.1:38791_solr",
"state":"active",
"type":"TLOG",
"force_set_state":"false"}},
"stateTimestamp":"1543581130778517947"}},
"router":{
"name":"compositeId",
"field":"shard_s"},
"maxShardsPerNode":"-1",
"autoAddReplicas":"true",
"nrtReplicas":1,
"tlogReplicas":1}
at
__randomizedtesting.SeedInfo.seed([FE5BD2BDD3FCC82B:760FED677D00A5D3]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.cloud.api.collections.AbstractCloudBackupRestoreTestCase.lambda$testBackupAndRestore$1(AbstractCloudBackupRestoreTestCase.java:339)
at java.util.HashMap.forEach(HashMap.java:1289)
at
org.apache.solr.cloud.api.collections.AbstractCloudBackupRestoreTestCase.testBackupAndRestore(AbstractCloudBackupRestoreTestCase.java:338)
at
org.apache.solr.cloud.api.collections.AbstractCloudBackupRestoreTestCase.test(AbstractCloudBackupRestoreTestCase.java:144)
at
org.apache.solr.cloud.api.collections.TestLocalFSCloudBackupRestore.test(TestLocalFSCloudBackupRestore.java:64)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:944)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 13019 lines...]
[junit4] Suite:
org.apache.solr.cloud.api.collections.TestHdfsCloudBackupRestore
[junit4] 2> 419791 INFO
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-http2-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.TestHdfsCloudBackupRestore_FE5BD2BDD3FCC82B-001/init-core-data-001
[junit4] 2> 419792 WARN
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=11 numCloses=11
[junit4] 2> 419792 INFO
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 419793 INFO
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 420160 WARN
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.a.h.u.NativeCodeLoader Unable to load native-hadoop library for your
platform... using builtin-java classes where applicable
[junit4] 1> Formatting using clusterid: testClusterID
[junit4] 2> 420657 WARN
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.a.h.m.i.MetricsConfig Cannot locate configuration: tried
hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4] 2> 420776 INFO
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.m.log Logging to org.apache.logging.slf4j.Log4jLogger@46819ae4 via
org.mortbay.log.Slf4jLog
[junit4] 2> 420788 WARN
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 421019 INFO
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.m.log jetty-6.1.26
[junit4] 2> 421046 INFO
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.m.log Extract
jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.4-tests.jar!/webapps/hdfs
to ./temp/Jetty_localhost_localdomain_36535_hdfs____.uw39jm/webapp
[junit4] 2> 421942 INFO
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost.localdomain:36535
[junit4] 2> 422556 WARN
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 422560 INFO
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.m.log jetty-6.1.26
[junit4] 2> 422568 INFO
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.m.log Extract
jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.4-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_45483_datanode____.askb9n/webapp
[junit4] 2> 423164 INFO
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:45483
[junit4] 2> 423392 WARN
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 423393 INFO
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.m.log jetty-6.1.26
[junit4] 2> 423404 INFO
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.m.log Extract
jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.4-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_40609_datanode____.n00jx2/webapp
[junit4] 2> 423877 INFO
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:40609
[junit4] 2> 425764 ERROR (DataNode:
[[[DISK]file:/home/jenkins/workspace/Lucene-Solr-http2-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.TestHdfsCloudBackupRestore_FE5BD2BDD3FCC82B-001/tempDir-001/hdfsBaseDir/data/data3/,
[DISK]file:/home/jenkins/workspace/Lucene-Solr-http2-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.TestHdfsCloudBackupRestore_FE5BD2BDD3FCC82B-001/tempDir-001/hdfsBaseDir/data/data4/]]
heartbeating to localhost.localdomain/127.0.0.1:41863) [ ]
o.a.h.h.s.d.DirectoryScanner
dfs.datanode.directoryscan.throttle.limit.ms.per.sec set to value below 1
ms/sec. Assuming default value of 1000
[junit4] 2> 425764 ERROR (DataNode:
[[[DISK]file:/home/jenkins/workspace/Lucene-Solr-http2-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.TestHdfsCloudBackupRestore_FE5BD2BDD3FCC82B-001/tempDir-001/hdfsBaseDir/data/data1/,
[DISK]file:/home/jenkins/workspace/Lucene-Solr-http2-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.TestHdfsCloudBackupRestore_FE5BD2BDD3FCC82B-001/tempDir-001/hdfsBaseDir/data/data2/]]
heartbeating to localhost.localdomain/127.0.0.1:41863) [ ]
o.a.h.h.s.d.DirectoryScanner
dfs.datanode.directoryscan.throttle.limit.ms.per.sec set to value below 1
ms/sec. Assuming default value of 1000
[junit4] 2> 425828 INFO (Block report processor) [ ] BlockStateChange
BLOCK* processReport 0x2ff94bcb3c5e6: from storage
DS-96278ba6-8b7a-4f21-a14f-5824a24b3103 node
DatanodeRegistration(127.0.0.1:46255,
datanodeUuid=69d9d245-237e-4cdd-8a7a-21fae2284067, infoPort=43469,
infoSecurePort=0, ipcPort=43343,
storageInfo=lv=-56;cid=testClusterID;nsid=1820139095;c=0), blocks: 0,
hasStaleStorage: true, processing time: 2 msecs
[junit4] 2> 425828 INFO (Block report processor) [ ] BlockStateChange
BLOCK* processReport 0x2ff94bcb3c5d4: from storage
DS-9be2699e-2119-42c4-8266-e1822c05b439 node
DatanodeRegistration(127.0.0.1:33673,
datanodeUuid=12c2e8e6-3ab6-415c-aae6-3c66e5b5fa8f, infoPort=37555,
infoSecurePort=0, ipcPort=44995,
storageInfo=lv=-56;cid=testClusterID;nsid=1820139095;c=0), blocks: 0,
hasStaleStorage: true, processing time: 0 msecs
[junit4] 2> 425828 INFO (Block report processor) [ ] BlockStateChange
BLOCK* processReport 0x2ff94bcb3c5e6: from storage
DS-110b7041-b7a6-4ddd-9164-3c55c4ccd41a node
DatanodeRegistration(127.0.0.1:46255,
datanodeUuid=69d9d245-237e-4cdd-8a7a-21fae2284067, infoPort=43469,
infoSecurePort=0, ipcPort=43343,
storageInfo=lv=-56;cid=testClusterID;nsid=1820139095;c=0), blocks: 0,
hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 425828 INFO (Block report processor) [ ] BlockStateChange
BLOCK* processReport 0x2ff94bcb3c5d4: from storage
DS-90457a06-86b7-48ac-abd6-695398375c3e node
DatanodeRegistration(127.0.0.1:33673,
datanodeUuid=12c2e8e6-3ab6-415c-aae6-3c66e5b5fa8f, infoPort=37555,
infoSecurePort=0, ipcPort=44995,
storageInfo=lv=-56;cid=testClusterID;nsid=1820139095;c=0), blocks: 0,
hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 426013 INFO
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in
/home/jenkins/workspace/Lucene-Solr-http2-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.TestHdfsCloudBackupRestore_FE5BD2BDD3FCC82B-001/tempDir-002
[junit4] 2> 426013 INFO
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 426014 INFO (Thread-3561) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 426014 INFO (Thread-3561) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 426015 ERROR (Thread-3561) [ ] 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> 426114 INFO
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:36343
[junit4] 2> 426116 INFO (zkConnectionManagerCallback-719-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 426121 WARN (jetty-launcher-716-thread-1) [ ]
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 426121 WARN (jetty-launcher-716-thread-2) [ ]
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 426122 INFO (jetty-launcher-716-thread-1) [ ]
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git:
c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_172-b11
[junit4] 2> 426122 INFO (jetty-launcher-716-thread-2) [ ]
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git:
c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_172-b11
[junit4] 2> 426127 INFO (jetty-launcher-716-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 426127 INFO (jetty-launcher-716-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 426127 INFO (jetty-launcher-716-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 426127 INFO (jetty-launcher-716-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 426127 INFO (jetty-launcher-716-thread-2) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 426127 INFO (jetty-launcher-716-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 426127 INFO (jetty-launcher-716-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@305333b5{/solr,null,AVAILABLE}
[junit4] 2> 426127 INFO (jetty-launcher-716-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@219f6ae0{/solr,null,AVAILABLE}
[junit4] 2> 426127 WARN (jetty-launcher-716-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@6735b226[provider=Conscrypt,keyStore=null,trustStore=null]
[junit4] 2> 426127 WARN (jetty-launcher-716-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@5e579c65[provider=Conscrypt,keyStore=null,trustStore=null]
[junit4] 2> 426128 INFO (jetty-launcher-716-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@688e1145{ssl,[ssl, alpn,
http/1.1, h2]}{127.0.0.1:39547}
[junit4] 2> 426128 INFO (jetty-launcher-716-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@20ce7ad{ssl,[ssl, alpn,
http/1.1, h2]}{127.0.0.1:36505}
[junit4] 2> 426128 INFO (jetty-launcher-716-thread-2) [ ]
o.e.j.s.Server Started @426187ms
[junit4] 2> 426128 INFO (jetty-launcher-716-thread-1) [ ]
o.e.j.s.Server Started @426187ms
[junit4] 2> 426128 INFO (jetty-launcher-716-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=39547}
[junit4] 2> 426128 INFO (jetty-launcher-716-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=36505}
[junit4] 2> 426128 ERROR (jetty-launcher-716-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 426128 ERROR (jetty-launcher-716-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 426128 INFO (jetty-launcher-716-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 426128 INFO (jetty-launcher-716-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 426128 INFO (jetty-launcher-716-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.0.0
[junit4] 2> 426128 INFO (jetty-launcher-716-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.0.0
[junit4] 2> 426128 INFO (jetty-launcher-716-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 426128 INFO (jetty-launcher-716-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 426128 INFO (jetty-launcher-716-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 426128 INFO (jetty-launcher-716-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 426128 INFO (jetty-launcher-716-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-11-30T12:06:41.206Z
[junit4] 2> 426128 INFO (jetty-launcher-716-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-11-30T12:06:41.206Z
[junit4] 2> 426130 INFO (zkConnectionManagerCallback-722-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 426130 INFO (zkConnectionManagerCallback-723-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 426130 INFO (jetty-launcher-716-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 426130 INFO (jetty-launcher-716-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 426134 INFO (jetty-launcher-716-thread-2) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@3d538549, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 426134 INFO (jetty-launcher-716-thread-1) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@3d538549, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 426134 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid
0x100324de0150001, likely client has closed socket
[junit4] 2> 426237 WARN (jetty-launcher-716-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@1940eb7a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 426248 WARN (jetty-launcher-716-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@1087313a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 426250 INFO (jetty-launcher-716-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36343/solr
[junit4] 2> 426253 INFO (zkConnectionManagerCallback-727-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 426258 INFO (zkConnectionManagerCallback-729-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 426294 INFO (jetty-launcher-716-thread-1)
[n:127.0.0.1:36505_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:36505_solr
[junit4] 2> 426294 INFO (jetty-launcher-716-thread-1)
[n:127.0.0.1:36505_solr ] o.a.s.c.Overseer Overseer
(id=72112904091271172-127.0.0.1:36505_solr-n_0000000000) starting
[junit4] 2> 426296 WARN (jetty-launcher-716-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@6cdc2ed1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 426309 INFO (zkConnectionManagerCallback-737-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 426310 INFO (jetty-launcher-716-thread-1)
[n:127.0.0.1:36505_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:36343/solr ready
[junit4] 2> 426317 INFO
(OverseerStateUpdate-72112904091271172-127.0.0.1:36505_solr-n_0000000000)
[n:127.0.0.1:36505_solr ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:36505_solr
[junit4] 2> 426322 INFO (jetty-launcher-716-thread-1)
[n:127.0.0.1:36505_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:36505_solr
[junit4] 2> 426326 INFO (zkCallback-728-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 426326 INFO (jetty-launcher-716-thread-1)
[n:127.0.0.1:36505_solr ] o.a.s.c.b.r.BackupRepositoryFactory Added backup
repository with configuration params {type = repository,name = hdfs,class =
org.apache.solr.core.backup.repository.HdfsBackupRepository,attributes =
{name=hdfs,
class=org.apache.solr.core.backup.repository.HdfsBackupRepository},args =
{location=/backup,solr.hdfs.home=hdfs://localhost.localdomain:41863/solr,solr.hdfs.confdir=}}
[junit4] 2> 426326 INFO (jetty-launcher-716-thread-1)
[n:127.0.0.1:36505_solr ] o.a.s.c.b.r.BackupRepositoryFactory Default
configuration for backup repository is with configuration params {type =
repository,name = hdfs,class =
org.apache.solr.core.backup.repository.HdfsBackupRepository,attributes =
{name=hdfs,
class=org.apache.solr.core.backup.repository.HdfsBackupRepository},args =
{location=/backup,solr.hdfs.home=hdfs://localhost.localdomain:41863/solr,solr.hdfs.confdir=}}
[junit4] 2> 426330 INFO (zkCallback-736-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 426334 WARN (jetty-launcher-716-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@1816e780[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 426342 INFO (jetty-launcher-716-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36343/solr
[junit4] 2> 426345 INFO (jetty-launcher-716-thread-1)
[n:127.0.0.1:36505_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 426351 INFO (zkConnectionManagerCallback-741-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 426359 INFO (jetty-launcher-716-thread-1)
[n:127.0.0.1:36505_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3d538549
[junit4] 2> 426361 INFO (zkConnectionManagerCallback-743-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 426364 INFO (jetty-launcher-716-thread-2)
[n:127.0.0.1:39547_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 426365 INFO (jetty-launcher-716-thread-1)
[n:127.0.0.1:36505_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3d538549
[junit4] 2> 426365 INFO (jetty-launcher-716-thread-1)
[n:127.0.0.1:36505_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3d538549
[junit4] 2> 426366 INFO (jetty-launcher-716-thread-2)
[n:127.0.0.1:39547_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 426366 INFO (jetty-launcher-716-thread-2)
[n:127.0.0.1:39547_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:39547_solr
[junit4] 2> 426366 INFO (jetty-launcher-716-thread-1)
[n:127.0.0.1:36505_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-http2-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.TestHdfsCloudBackupRestore_FE5BD2BDD3FCC82B-001/tempDir-002/node1/.
[junit4] 2> 426366 INFO (zkCallback-728-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 426369 INFO (zkCallback-736-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 426370 INFO (jetty-launcher-716-thread-2)
[n:127.0.0.1:39547_solr ] o.a.s.c.b.r.BackupRepositoryFactory Added backup
repository with configuration params {type = repository,name = hdfs,class =
org.apache.solr.core.backup.repository.HdfsBackupRepository,attributes =
{name=hdfs,
class=org.apache.solr.core.backup.repository.HdfsBackupRepository},args =
{location=/backup,solr.hdfs.home=hdfs://localhost.localdomain:41863/solr,solr.hdfs.confdir=}}
[junit4] 2> 426370 INFO (jetty-launcher-716-thread-2)
[n:127.0.0.1:39547_solr ] o.a.s.c.b.r.BackupRepositoryFactory Default
configuration for backup repository is with configuration params {type =
repository,name = hdfs,class =
org.apache.solr.core.backup.repository.HdfsBackupRepository,attributes =
{name=hdfs,
class=org.apache.solr.core.backup.repository.HdfsBackupRepository},args =
{location=/backup,solr.hdfs.home=hdfs://localhost.localdomain:41863/solr,solr.hdfs.confdir=}}
[junit4] 2> 426376 INFO (zkCallback-742-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 426389 INFO (zkConnectionManagerCallback-750-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 426389 INFO (jetty-launcher-716-thread-2)
[n:127.0.0.1:39547_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 426390 INFO (jetty-launcher-716-thread-2)
[n:127.0.0.1:39547_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:36343/solr ready
[junit4] 2> 426397 INFO (jetty-launcher-716-thread-2)
[n:127.0.0.1:39547_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 426408 INFO (jetty-launcher-716-thread-2)
[n:127.0.0.1:39547_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3d538549
[junit4] 2> 426414 INFO (jetty-launcher-716-thread-2)
[n:127.0.0.1:39547_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3d538549
[junit4] 2> 426414 INFO (jetty-launcher-716-thread-2)
[n:127.0.0.1:39547_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3d538549
[junit4] 2> 426415 INFO (jetty-launcher-716-thread-2)
[n:127.0.0.1:39547_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-http2-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.TestHdfsCloudBackupRestore_FE5BD2BDD3FCC82B-001/tempDir-002/node2/.
[junit4] 2> 426432 INFO (zkConnectionManagerCallback-753-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 426437 INFO (zkConnectionManagerCallback-758-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 426438 INFO
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 426439 INFO
(SUITE-TestHdfsCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36343/solr ready
[junit4] 2> 426493 INFO
(TEST-TestHdfsCloudBackupRestore.test-seed#[FE5BD2BDD3FCC82B]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 426500 INFO (qtp1225247052-6620) [n:127.0.0.1:36505_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
collection.configName=conf1&version=2&pullReplicas=0&property.customKey=customValue&maxShardsPerNode=-1&router.field=shard_s&autoAddReplicas=true&name=hdfsbackuprestore&nrtReplicas=1&action=CREATE&numShards=2&tlogReplicas=0&wt=javabin
and sendToOCPQueue=true
[junit4] 2> 426502 INFO
(OverseerThreadFactory-1709-thread-1-processing-n:127.0.0.1:36505_solr)
[n:127.0.0.1:36505_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
hdfsbackuprestore
[junit4] 2> 426610 INFO (qtp1225247052-6744) [n:127.0.0.1:36505_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 426617 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 426619 INFO
(OverseerStateUpdate-72112904091271172-127.0.0.1:36505_solr-n_0000000000)
[n:127.0.0.1:36505_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"hdfsbackuprestore",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"hdfsbackuprestore_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:39547/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 426620 INFO
(OverseerStateUpdate-72112904091271172-127.0.0.1:36505_solr-n_0000000000)
[n:127.0.0.1:36505_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"hdfsbackuprestore",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"hdfsbackuprestore_shard2_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:36505/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 426834 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.h.a.CoreAdminOperation core create
command
qt=/admin/cores&collection.configName=conf1&newCollection=true&collection=hdfsbackuprestore&version=2&replicaType=NRT&property.customKey=customValue&coreNodeName=core_node4&name=hdfsbackuprestore_shard2_replica_n2&action=CREATE&numShards=2&shard=shard2&wt=javabin
[junit4] 2> 426834 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.c.TransientSolrCoreCacheDefault
Allocating transient cache for 2147483647 transient cores
[junit4] 2> 426834 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create
command
qt=/admin/cores&collection.configName=conf1&newCollection=true&collection=hdfsbackuprestore&version=2&replicaType=NRT&property.customKey=customValue&coreNodeName=core_node3&name=hdfsbackuprestore_shard1_replica_n1&action=CREATE&numShards=2&shard=shard1&wt=javabin
[junit4] 2> 427844 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 8.0.0
[junit4] 2> 427844 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 8.0.0
[junit4] 2> 427851 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.s.IndexSchema
[hdfsbackuprestore_shard1_replica_n1] Schema name=minimal
[junit4] 2> 427851 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.s.IndexSchema
[hdfsbackuprestore_shard2_replica_n2] Schema name=minimal
[junit4] 2> 427853 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 427853 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore
'hdfsbackuprestore_shard1_replica_n1' using configuration from collection
hdfsbackuprestore, trusted=true
[junit4] 2> 427853 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 427853 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring
for 'solr.core.hdfsbackuprestore.shard1.replica_n1' (registry
'solr.core.hdfsbackuprestore.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3d538549
[junit4] 2> 427853 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.c.CoreContainer Creating SolrCore
'hdfsbackuprestore_shard2_replica_n2' using configuration from collection
hdfsbackuprestore, trusted=true
[junit4] 2> 427854 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.m.r.SolrJmxReporter JMX monitoring
for 'solr.core.hdfsbackuprestore.shard2.replica_n2' (registry
'solr.core.hdfsbackuprestore.shard2.replica_n2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3d538549
[junit4] 2> 427858 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.c.SolrCore
[[hdfsbackuprestore_shard1_replica_n1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-http2-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.TestHdfsCloudBackupRestore_FE5BD2BDD3FCC82B-001/tempDir-002/node2/hdfsbackuprestore_shard1_replica_n1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-http2-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.TestHdfsCloudBackupRestore_FE5BD2BDD3FCC82B-001/tempDir-002/node2/./hdfsbackuprestore_shard1_replica_n1/data/]
[junit4] 2> 427858 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.c.SolrCore
[[hdfsbackuprestore_shard2_replica_n2] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-http2-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.TestHdfsCloudBackupRestore_FE5BD2BDD3FCC82B-001/tempDir-002/node1/hdfsbackuprestore_shard2_replica_n2],
dataDir=[/home/jenkins/workspace/Lucene-Solr-http2-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.TestHdfsCloudBackupRestore_FE5BD2BDD3FCC82B-001/tempDir-002/node1/./hdfsbackuprestore_shard2_replica_n2/data/]
[junit4] 2> 427986 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 427986 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 427988 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit:
disabled
[junit4] 2> 427988 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit:
disabled
[junit4] 2> 427989 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@23aaa6bb[hdfsbackuprestore_shard1_replica_n1] main]
[junit4] 2> 427990 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 427991 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 427991 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will
be reserved for 10000ms.
[junit4] 2> 427991 INFO
(searcherExecutor-1718-thread-1-processing-n:127.0.0.1:39547_solr
x:hdfsbackuprestore_shard1_replica_n1 c:hdfsbackuprestore s:shard1
r:core_node3) [n:127.0.0.1:39547_solr c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.c.SolrCore
[hdfsbackuprestore_shard1_replica_n1] Registered new searcher
Searcher@23aaa6bb[hdfsbackuprestore_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 427991 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1618560525867679744
[junit4] 2> 427995 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update
of terms at /collections/hdfsbackuprestore/terms/shard1 to
Terms{values={core_node3=0}, version=0}
[junit4] 2> 427996 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext
Enough replicas found to continue.
[junit4] 2> 427996 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may
be the new leader - try and sync
[junit4] 2> 427996 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:39547/solr/hdfsbackuprestore_shard1_replica_n1/
[junit4] 2> 427997 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now
sync replicas to me
[junit4] 2> 427997 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.c.SyncStrategy
https://127.0.0.1:39547/solr/hdfsbackuprestore_shard1_replica_n1/ has no
replicas
[junit4] 2> 427997 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 427997 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 427998 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit:
disabled
[junit4] 2> 427998 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.u.CommitTracker Soft AutoCommit:
disabled
[junit4] 2> 427998 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am
the new leader:
https://127.0.0.1:39547/solr/hdfsbackuprestore_shard1_replica_n1/ shard1
[junit4] 2> 428000 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.s.SolrIndexSearcher Opening
[Searcher@59213e95[hdfsbackuprestore_shard2_replica_n2] main]
[junit4] 2> 428000 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 428000 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.r.ManagedResourceStorage Loaded
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 428001 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.h.ReplicationHandler Commits will
be reserved for 10000ms.
[junit4] 2> 428001 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1618560525878165504
[junit4] 2> 428001 INFO
(searcherExecutor-1719-thread-1-processing-n:127.0.0.1:36505_solr
x:hdfsbackuprestore_shard2_replica_n2 c:hdfsbackuprestore s:shard2
r:core_node4) [n:127.0.0.1:36505_solr c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.c.SolrCore
[hdfsbackuprestore_shard2_replica_n2] Registered new searcher
Searcher@59213e95[hdfsbackuprestore_shard2_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 428004 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.c.ZkShardTerms Successful update
of terms at /collections/hdfsbackuprestore/terms/shard2 to
Terms{values={core_node4=0}, version=0}
[junit4] 2> 428005 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext
Enough replicas found to continue.
[junit4] 2> 428005 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I may
be the new leader - try and sync
[junit4] 2> 428005 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:36505/solr/hdfsbackuprestore_shard2_replica_n2/
[junit4] 2> 428005 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.c.SyncStrategy Sync Success - now
sync replicas to me
[junit4] 2> 428005 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.c.SyncStrategy
https://127.0.0.1:36505/solr/hdfsbackuprestore_shard2_replica_n2/ has no
replicas
[junit4] 2> 428006 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I am
the new leader:
https://127.0.0.1:36505/solr/hdfsbackuprestore_shard2_replica_n2/ shard2
[junit4] 2> 428151 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no
recovery necessary
[junit4] 2> 428152 INFO (qtp68373571-6619) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null
path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&newCollection=true&collection=hdfsbackuprestore&version=2&replicaType=NRT&property.customKey=customValue&coreNodeName=core_node3&name=hdfsbackuprestore_shard1_replica_n1&action=CREATE&numShards=2&shard=shard1&wt=javabin}
status=0 QTime=1318
[junit4] 2> 428158 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.c.ZkController I am the leader, no
recovery necessary
[junit4] 2> 428160 INFO (qtp1225247052-6611) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.s.HttpSolrCall [admin] webapp=null
path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&newCollection=true&collection=hdfsbackuprestore&version=2&replicaType=NRT&property.customKey=customValue&coreNodeName=core_node4&name=hdfsbackuprestore_shard2_replica_n2&action=CREATE&numShards=2&shard=shard2&wt=javabin}
status=0 QTime=1326
[junit4] 2> 428162 INFO (qtp1225247052-6620) [n:127.0.0.1:36505_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> 428260 INFO (zkCallback-728-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/hdfsbackuprestore/state.json] for collection
[hdfsbackuprestore] has occurred - updating... (live nodes size: [2])
[junit4] 2> 428260 INFO (zkCallback-742-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/hdfsbackuprestore/state.json] for collection
[hdfsbackuprestore] has occurred - updating... (live nodes size: [2])
[junit4] 2> 428503 INFO
(OverseerCollectionConfigSetProcessor-72112904091271172-127.0.0.1:36505_solr-n_0000000000)
[n:127.0.0.1:36505_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> 429162 INFO (qtp1225247052-6620) [n:127.0.0.1:36505_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={collection.configName=conf1&version=2&pullReplicas=0&property.customKey=customValue&maxShardsPerNode=-1&router.field=shard_s&autoAddReplicas=true&name=hdfsbackuprestore&nrtReplicas=1&action=CREATE&numShards=2&tlogReplicas=0&wt=javabin}
status=0 QTime=2661
[junit4] 2> 429169 INFO (qtp1225247052-6618) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.c.ZkShardTerms Successful update
of terms at /collections/hdfsbackuprestore/terms/shard2 to
Terms{values={core_node4=1}, version=1}
[junit4] 2> 429170 INFO (qtp1225247052-6618) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.u.p.LogUpdateProcessorFactory
[hdfsbackuprestore_shard2_replica_n2] webapp=/solr path=/update
params={wt=javabin&version=2}{add=[0 (1618560527098707968), 1
(1618560527100805120), 2 (1618560527100805121), 3 (1618560527100805122), 4
(1618560527100805123), 5 (1618560527100805124), 6 (1618560527100805125), 7
(1618560527100805126), 8 (1618560527100805127), 9 (1618560527100805128), ...
(58 adds)]} 0 4
[junit4] 2> 429181 INFO (qtp68373571-6610) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1618560527115485184,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 429181 INFO (qtp68373571-6610) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 No
uncommitted changes. Skipping IW.commit.
[junit4] 2> 429182 INFO (qtp68373571-6610) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2
end_commit_flush
[junit4] 2> 429182 INFO (qtp68373571-6610) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory
[hdfsbackuprestore_shard1_replica_n1] webapp=/solr path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:39547/solr/hdfsbackuprestore_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 1
[junit4] 2> 429183 INFO (qtp1225247052-6618) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1618560527117582336,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 429183 INFO (qtp1225247052-6618) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.u.SolrIndexWriter Calling
setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4ac0168c
commitCommandVersion:1618560527117582336
[junit4] 2> 430053 INFO (qtp1225247052-6618) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.s.SolrIndexSearcher Opening
[Searcher@6d2b8a70[hdfsbackuprestore_shard2_replica_n2] main]
[junit4] 2> 430054 INFO (qtp1225247052-6618) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.u.DirectUpdateHandler2
end_commit_flush
[junit4] 2> 430055 INFO
(searcherExecutor-1719-thread-1-processing-n:127.0.0.1:36505_solr
x:hdfsbackuprestore_shard2_replica_n2 c:hdfsbackuprestore s:shard2
r:core_node4) [n:127.0.0.1:36505_solr c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.c.SolrCore
[hdfsbackuprestore_shard2_replica_n2] Registered new searcher
Searcher@6d2b8a70[hdfsbackuprestore_shard2_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C58)))}
[junit4] 2> 430055 INFO (qtp1225247052-6618) [n:127.0.0.1:36505_solr
c:hdfsbackuprestore s:shard2 r:core_node4
x:hdfsbackuprestore_shard2_replica_n2] o.a.s.u.p.LogUpdateProcessorFactory
[hdfsbackuprestore_shard2_replica_n2] webapp=/solr path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:39547/solr/hdfsbackuprestore_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 872
[junit4] 2> 430056 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1 r:core_node3
x:hdfsbackuprestore_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory
[hdfsbackuprestore_shard1_replica_n1] webapp=/solr path=/update
params={_stateVer_=hdfsbackuprestore:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 885
[junit4] 2> 430057 INFO
(TEST-TestHdfsCloudBackupRestore.test-seed#[FE5BD2BDD3FCC82B]) [ ]
o.a.s.c.a.c.AbstractCloudBackupRestoreTestCase Indexed 58 docs to collection:
hdfsbackuprestore
[junit4] 2> 430057 INFO (qtp1225247052-6620) [n:127.0.0.1:36505_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :splitshard with params
action=SPLITSHARD&collection=hdfsbackuprestore&shard=shard1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 430063 INFO (qtp68373571-6614) [n:127.0.0.1:39547_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace&wt=javabin&version=2&group=solr.node}
status=0 QTime=0
[junit4] 2> 430064 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.hdfsbackuprestore.shard1.replica_n1:INDEX.sizeInBytes}
status=0 QTime=0
[junit4] 2> 430065 INFO
(OverseerThreadFactory-1709-thread-2-processing-n:127.0.0.1:36505_solr)
[n:127.0.0.1:36505_solr c:hdfsbackuprestore s:shard1 ]
o.a.s.c.a.c.SplitShardCmd numSubShards set at: 2
[junit4] 2> 430167 INFO (zkCallback-728-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/hdfsbackuprestore/state.json] for collection
[hdfsbackuprestore] has occurred - updating... (live nodes size: [2])
[junit4] 2> 430167 INFO (zkCallback-742-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/hdfsbackuprestore/state.json] for collection
[hdfsbackuprestore] has occurred - updating... (live nodes size: [2])
[junit4] 2> 431071 INFO (qtp1225247052-6622) [n:127.0.0.1:36505_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.hdfsbackuprestore.shard2.replica_n2:INDEX.sizeInBytes}
status=0 QTime=0
[junit4] 2> 431072 INFO (qtp1225247052-6750) [n:127.0.0.1:36505_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 431073 INFO (qtp68373571-6614) [n:127.0.0.1:39547_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.hdfsbackuprestore.shard1.replica_n1:INDEX.sizeInBytes}
status=0 QTime=0
[junit4] 2> 431074 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 431075 INFO
(OverseerThreadFactory-1709-thread-2-processing-n:127.0.0.1:36505_solr)
[n:127.0.0.1:36505_solr c:hdfsbackuprestore s:shard1 ]
o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:39547_solr for creating new
replica of shard shard1_0 for collection hdfsbackuprestore
[junit4] 2> 431076 INFO
(OverseerStateUpdate-72112904091271172-127.0.0.1:36505_solr-n_0000000000)
[n:127.0.0.1:36505_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"addreplica",
[junit4] 2> "collection":"hdfsbackuprestore",
[junit4] 2> "shard":"shard1_0",
[junit4] 2> "core":"hdfsbackuprestore_shard1_0_replica_n5",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:39547/solr";,
[junit4] 2> "node_name":"127.0.0.1:39547_solr",
[junit4] 2> "type":"NRT"}
[junit4] 2> 431177 INFO (zkCallback-742-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/hdfsbackuprestore/state.json] for collection
[hdfsbackuprestore] has occurred - updating... (live nodes size: [2])
[junit4] 2> 431177 INFO (zkCallback-728-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/hdfsbackuprestore/state.json] for collection
[hdfsbackuprestore] has occurred - updating... (live nodes size: [2])
[junit4] 2> 431278 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.h.a.CoreAdminOperation core
create command
qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf1&name=hdfsbackuprestore_shard1_0_replica_n5&action=CREATE&collection=hdfsbackuprestore&shard=shard1_0&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 431285 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 8.0.0
[junit4] 2> 431290 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.s.IndexSchema
[hdfsbackuprestore_shard1_0_replica_n5] Schema name=minimal
[junit4] 2> 431292 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 431292 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.c.CoreContainer Creating
SolrCore 'hdfsbackuprestore_shard1_0_replica_n5' using configuration from
collection hdfsbackuprestore, trusted=true
[junit4] 2> 431292 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr.core.hdfsbackuprestore.shard1_0.replica_n5' (registry
'solr.core.hdfsbackuprestore.shard1_0.replica_n5') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3d538549
[junit4] 2> 431292 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.c.SolrCore
[[hdfsbackuprestore_shard1_0_replica_n5] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-http2-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.TestHdfsCloudBackupRestore_FE5BD2BDD3FCC82B-001/tempDir-002/node2/hdfsbackuprestore_shard1_0_replica_n5],
dataDir=[/home/jenkins/workspace/Lucene-Solr-http2-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.TestHdfsCloudBackupRestore_FE5BD2BDD3FCC82B-001/tempDir-002/node2/./hdfsbackuprestore_shard1_0_replica_n5/data/]
[junit4] 2> 431342 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 431342 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 431343 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.u.CommitTracker Hard AutoCommit:
disabled
[junit4] 2> 431343 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.u.CommitTracker Soft AutoCommit:
disabled
[junit4] 2> 431345 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.s.SolrIndexSearcher Opening
[Searcher@74f518d3[hdfsbackuprestore_shard1_0_replica_n5] main]
[junit4] 2> 431346 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 431346 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.r.ManagedResourceStorage Loaded
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 431347 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000ms.
[junit4] 2> 431347 INFO
(searcherExecutor-1728-thread-1-processing-n:127.0.0.1:39547_solr
x:hdfsbackuprestore_shard1_0_replica_n5 c:hdfsbackuprestore s:shard1_0
r:core_node7) [n:127.0.0.1:39547_solr c:hdfsbackuprestore s:shard1_0
r:core_node7 x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.c.SolrCore
[hdfsbackuprestore_shard1_0_replica_n5] Registered new searcher
Searcher@74f518d3[hdfsbackuprestore_shard1_0_replica_n5]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 431347 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1618560529386700800
[junit4] 2> 431348 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.u.UpdateLog Starting to buffer
updates. FSUpdateLog{state=ACTIVE, tlog=null}
[junit4] 2> 431350 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.c.ZkShardTerms Successful update
of terms at /collections/hdfsbackuprestore/terms/shard1_0 to
Terms{values={core_node7=0}, version=0}
[junit4] 2> 431351 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.c.ShardLeaderElectionContext
Enough replicas found to continue.
[junit4] 2> 431351 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.c.ShardLeaderElectionContext I
may be the new leader - try and sync
[junit4] 2> 431351 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:39547/solr/hdfsbackuprestore_shard1_0_replica_n5/
[junit4] 2> 431351 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.c.SyncStrategy Sync Success -
now sync replicas to me
[junit4] 2> 431351 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.c.SyncStrategy
https://127.0.0.1:39547/solr/hdfsbackuprestore_shard1_0_replica_n5/ has no
replicas
[junit4] 2> 431352 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.c.ShardLeaderElectionContext I
am the new leader:
https://127.0.0.1:39547/solr/hdfsbackuprestore_shard1_0_replica_n5/ shard1_0
[junit4] 2> 431454 INFO (zkCallback-742-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/hdfsbackuprestore/state.json] for collection
[hdfsbackuprestore] has occurred - updating... (live nodes size: [2])
[junit4] 2> 431454 INFO (zkCallback-728-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/hdfsbackuprestore/state.json] for collection
[hdfsbackuprestore] has occurred - updating... (live nodes size: [2])
[junit4] 2> 431503 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.c.ZkController I am the leader,
no recovery necessary
[junit4] 2> 431505 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_0 r:core_node7
x:hdfsbackuprestore_shard1_0_replica_n5] o.a.s.s.HttpSolrCall [admin]
webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf1&name=hdfsbackuprestore_shard1_0_replica_n5&action=CREATE&collection=hdfsbackuprestore&shard=shard1_0&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=227
[junit4] 2> 431609 INFO (zkCallback-742-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/hdfsbackuprestore/state.json] for collection
[hdfsbackuprestore] has occurred - updating... (live nodes size: [2])
[junit4] 2> 431609 INFO (zkCallback-728-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/hdfsbackuprestore/state.json] for collection
[hdfsbackuprestore] has occurred - updating... (live nodes size: [2])
[junit4] 2> 432510 INFO (qtp1225247052-6622) [n:127.0.0.1:36505_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.hdfsbackuprestore.shard2.replica_n2:INDEX.sizeInBytes}
status=0 QTime=1
[junit4] 2> 432511 INFO (qtp1225247052-6750) [n:127.0.0.1:36505_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 432513 INFO (qtp68373571-6614) [n:127.0.0.1:39547_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.hdfsbackuprestore.shard1.replica_n1:INDEX.sizeInBytes&key=solr.core.hdfsbackuprestore.shard1_0.replica_n5:INDEX.sizeInBytes}
status=0 QTime=1
[junit4] 2> 432515 INFO (qtp68373571-6621) [n:127.0.0.1:39547_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=1
[junit4] 2> 432517 INFO
(OverseerThreadFactory-1709-thread-2-processing-n:127.0.0.1:36505_solr)
[n:127.0.0.1:36505_solr c:hdfsbackuprestore s:shard1 ]
o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:39547_solr for creating new
replica of shard shard1_1 for collection hdfsbackuprestore
[junit4] 2> 432517 INFO
(OverseerStateUpdate-72112904091271172-127.0.0.1:36505_solr-n_0000000000)
[n:127.0.0.1:36505_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"addreplica",
[junit4] 2> "collection":"hdfsbackuprestore",
[junit4] 2> "shard":"shard1_1",
[junit4] 2> "core":"hdfsbackuprestore_shard1_1_replica_n6",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:39547/solr";,
[junit4] 2> "node_name":"127.0.0.1:39547_solr",
[junit4] 2> "type":"NRT"}
[junit4] 2> 432619 INFO (zkCallback-728-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/hdfsbackuprestore/state.json] for collection
[hdfsbackuprestore] has occurred - updating... (live nodes size: [2])
[junit4] 2> 432619 INFO (zkCallback-742-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/hdfsbackuprestore/state.json] for collection
[hdfsbackuprestore] has occurred - updating... (live nodes size: [2])
[junit4] 2> 432719 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.h.a.CoreAdminOperation core
create command
qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf1&name=hdfsbackuprestore_shard1_1_replica_n6&action=CREATE&collection=hdfsbackuprestore&shard=shard1_1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 432727 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_1 r:core_node8
x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 8.0.0
[junit4] 2> 432732 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_1 r:core_node8
x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.s.IndexSchema
[hdfsbackuprestore_shard1_1_replica_n6] Schema name=minimal
[junit4] 2> 432734 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_1 r:core_node8
x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 432734 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_1 r:core_node8
x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.c.CoreContainer Creating
SolrCore 'hdfsbackuprestore_shard1_1_replica_n6' using configuration from
collection hdfsbackuprestore, trusted=true
[junit4] 2> 432735 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_1 r:core_node8
x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr.core.hdfsbackuprestore.shard1_1.replica_n6' (registry
'solr.core.hdfsbackuprestore.shard1_1.replica_n6') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3d538549
[junit4] 2> 432735 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_1 r:core_node8
x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.c.SolrCore
[[hdfsbackuprestore_shard1_1_replica_n6] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-http2-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.TestHdfsCloudBackupRestore_FE5BD2BDD3FCC82B-001/tempDir-002/node2/hdfsbackuprestore_shard1_1_replica_n6],
dataDir=[/home/jenkins/workspace/Lucene-Solr-http2-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.TestHdfsCloudBackupRestore_FE5BD2BDD3FCC82B-001/tempDir-002/node2/./hdfsbackuprestore_shard1_1_replica_n6/data/]
[junit4] 2> 432795 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_1 r:core_node8
x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 432795 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_1 r:core_node8
x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 432809 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_1 r:core_node8
x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.u.CommitTracker Hard AutoCommit:
disabled
[junit4] 2> 432809 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_1 r:core_node8
x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.u.CommitTracker Soft AutoCommit:
disabled
[junit4] 2> 432810 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_1 r:core_node8
x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.s.SolrIndexSearcher Opening
[Searcher@51bc4e08[hdfsbackuprestore_shard1_1_replica_n6] main]
[junit4] 2> 432811 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_1 r:core_node8
x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 432811 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_1 r:core_node8
x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.r.ManagedResourceStorage Loaded
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 432812 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_1 r:core_node8
x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000ms.
[junit4] 2> 432812 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_1 r:core_node8
x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1618560530922864640
[junit4] 2> 432812 INFO
(searcherExecutor-1733-thread-1-processing-n:127.0.0.1:39547_solr
x:hdfsbackuprestore_shard1_1_replica_n6 c:hdfsbackuprestore s:shard1_1
r:core_node8) [n:127.0.0.1:39547_solr c:hdfsbackuprestore s:shard1_1
r:core_node8 x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.c.SolrCore
[hdfsbackuprestore_shard1_1_replica_n6] Registered new searcher
Searcher@51bc4e08[hdfsbackuprestore_shard1_1_replica_n6]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 432813 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_1 r:core_node8
x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.u.UpdateLog Starting to buffer
updates. FSUpdateLog{state=ACTIVE, tlog=null}
[junit4] 2> 432814 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_1 r:core_node8
x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.c.ZkShardTerms Successful update
of terms at /collections/hdfsbackuprestore/terms/shard1_1 to
Terms{values={core_node8=0}, version=0}
[junit4] 2> 432815 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_1 r:core_node8
x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.c.ShardLeaderElectionContext
Enough replicas found to continue.
[junit4] 2> 432815 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_1 r:core_node8
x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.c.ShardLeaderElectionContext I
may be the new leader - try and sync
[junit4] 2> 432815 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_1 r:core_node8
x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:39547/solr/hdfsbackuprestore_shard1_1_replica_n6/
[junit4] 2> 432815 INFO (qtp68373571-6749) [n:127.0.0.1:39547_solr
c:hdfsbackuprestore s:shard1_1 r:core_node8
x:hdfsbackuprestore_shard1_1_replica_n6] o.a.s.c.SyncStrategy Sync Success -
now sync replicas to me
[...truncated too long message...]
44 INFO (jetty-closer-5674-thread-2) [ ] o.e.j.s.session node0 Stopped
scavenging
[junit4] 2> 1958644 ERROR
(SUITE-TestLocalFSCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper
server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 1958644 INFO
(SUITE-TestLocalFSCloudBackupRestore-seed#[FE5BD2BDD3FCC82B]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:40413 40413
[junit4] 2> 1958780 INFO (Thread-14111) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:40413 40413
[junit4] 2> 1958780 WARN (Thread-14111) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 10
/solr/collections/backuprestore_restored/terms/shard1_0
[junit4] 2> 10
/solr/collections/backuprestore_restored/terms/shard1_1
[junit4] 2> 6
/solr/collections/backuprestore_restored/terms/shard2
[junit4] 2> 5 /solr/aliases.json
[junit4] 2> 3 /solr/collections/backuprestore/terms/shard1_0
[junit4] 2> 3 /solr/collections/backuprestore/terms/shard1_1
[junit4] 2> 3 /solr/collections/backuprestore/terms/shard2
[junit4] 2> 2 /solr/security.json
[junit4] 2> 2 /solr/configs/conf1
[junit4] 2> 2 /solr/collections/backuprestore/terms/shard1
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 5 /solr/clusterstate.json
[junit4] 2> 5 /solr/clusterprops.json
[junit4] 2> 4
/solr/collections/backuprestore_restored/state.json
[junit4] 2> 2 /solr/collections/backuprestore/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 5 /solr/live_nodes
[junit4] 2> 5 /solr/collections
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-http2-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.api.collections.TestLocalFSCloudBackupRestore_FE5BD2BDD3FCC82B-001
[junit4] 2> Nov 30, 2018 12:32:13 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=CheapBastard,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@4ff5e4fc),
locale=ms-MY, timezone=Atlantic/Azores
[junit4] 2> NOTE: Linux 4.15.0-39-generic amd64/Oracle Corporation
1.8.0_172 (64-bit)/cpus=8,threads=1,free=221045704,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [TestManagedResourceStorage,
PeerSyncWithIndexFingerprintCachingTest, CdcrReplicationHandlerTest,
TestFunctionQuery, TestHdfsUpdateLog, TestImpersonationWithHadoopAuth,
SolrInfoBeanTest, SyncSliceTest, TestIBSimilarityFactory, NumericFieldsTest,
SpatialFilterTest, SolrRrdBackendFactoryTest, TestConfigSetsAPI, TestCSVLoader,
TestQuerySenderListener, TestJsonFacetsStatsParsing, OrderedExecutorTest,
HighlighterTest, CurrencyFieldTypeTest, DataDrivenBlockJoinTest,
AutoscalingHistoryHandlerTest, IndexSchemaTest, TestFieldCacheVsDocValues,
TestSweetSpotSimilarityFactory, TestEmbeddedSolrServerConstructors,
TestXmlQParser, MinimalSchemaTest, HdfsBasicDistributedZkTest, TestLazyCores,
TestSchemaManager, ProtectedTermFilterFactoryTest, TestDistribIDF,
TestInfoStreamLogging, VMParamsZkACLAndCredentialsProvidersTest,
SuggestComponentContextFilterQueryTest, RootFieldTest,
TestLegacyNumericRangeQueryBuilder, TestNonDefinedSimilarityFactory,
TestRandomFaceting, TestFreeTextSuggestions, TestFilteredDocIdSet,
CustomHighlightComponentTest, HttpPartitionTest, TriggerIntegrationTest,
TestSolrJ, TestLRUStatsCache, TestReqParamsAPI, CollectionTooManyReplicasTest,
TestUtils, TestCollectionsAPIViaSolrCloudCluster, InfoHandlerTest,
AddBlockUpdateTest, TestScoreJoinQPNoScore, SolrPluginUtilsTest,
FullSolrCloudDistribCmdsTest, BasicFunctionalityTest, TestSimComputePlanAction,
TestHalfAndHalfDocValues, AtomicUpdatesTest, TestCloudPivotFacet,
NodeLostTriggerTest, IndexSizeTriggerTest, SolrCoreCheckLockOnStartupTest,
TestSolrCLIRunExample, AliasIntegrationTest, TestGeoJSONResponseWriter,
TestPolicyCloud, PKIAuthenticationIntegrationTest, MBeansHandlerTest,
CoreAdminOperationTest, IndexBasedSpellCheckerTest, ResponseBuilderTest,
TestIntervalFaceting, CreateCollectionCleanupTest, HdfsNNFailoverTest,
TestFieldCacheReopen, TestComplexPhraseLeadingWildcard, TestCoreAdminApis,
TestSimPolicyCloud, TestPhraseSuggestions, DisMaxRequestHandlerTest,
NoCacheHeaderTest, TestMultiValuedNumericRangeQuery, MaxSizeAutoCommitTest,
IgnoreCommitOptimizeUpdateProcessorFactoryTest,
UUIDUpdateProcessorFallbackTest, SpellPossibilityIteratorTest,
CheckHdfsIndexTest, TestPrepRecovery, RangeFacetCloudTest,
TestUniqueKeyFieldResource, XmlUpdateRequestHandlerTest,
TestClassicSimilarityFactory, TestReloadDeadlock,
MetricsHistoryIntegrationTest, TestSimExecutePlanAction, TestDynamicLoading,
ShufflingReplicaListTransformerTest, FastVectorHighlighterTest,
TestSortByMinMaxFunction, CacheHeaderTest, TermVectorComponentTest,
SearchRateTriggerIntegrationTest, RequiredFieldsTest,
AutoAddReplicasPlanActionTest, SolrGraphiteReporterTest, TestRandomFlRTGCloud,
TestUseDocValuesAsStored, TestSubQueryTransformerCrossCore,
DocumentAnalysisRequestHandlerTest, TestLuceneMatchVersion,
SolrMetricReporterTest, OutOfBoxZkACLAndCredentialsProvidersTest,
ConnectionReuseTest, TestRTGBase, TestSolrCloudWithDelegationTokens,
CloudMLTQParserTest, TestSolr4Spatial2, TestSimLargeCluster,
TestSQLHandlerNonCloud, TestBinaryResponseWriter, TestRawTransformer,
CdcrBidirectionalTest, TestCloudDeleteByQuery, TaggerTest,
RestartWhileUpdatingTest, ReplaceNodeNoTargetTest,
SignatureUpdateProcessorFactoryTest, BigEndianAscendingWordSerializerTest,
TestRuleBasedAuthorizationPlugin, RulesTest, DistributedUpdateProcessorTest,
TestNumericTerms32, TokenizerChainTest, TestSurroundQueryParser,
ChaosMonkeyNothingIsSafeTest, SuggesterTest, NodeAddedTriggerIntegrationTest,
TestJoin, BasicDistributedZkTest, ChaosMonkeySafeLeaderTest,
ChaosMonkeySafeLeaderWithPullReplicasTest, CollectionsAPISolrJTest,
DistribJoinFromCollectionTest, DistributedVersionInfoTest, LeaderElectionTest,
LeaderVoteWaitTimeoutTest, MissingSegmentRecoveryTest,
MoveReplicaHDFSFailoverTest, OverseerCollectionConfigSetProcessorTest,
OverseerModifyCollectionTest, OverseerRolesTest, OverseerTest,
SSLMigrationTest, SaslZkACLProviderTest, ShardRoutingCustomTest,
SharedFSAutoReplicaFailoverTest, SliceStateTest, SolrCLIZkUtilsTest,
SolrCloudExampleTest, TestCloudSearcherWarming, TestRebalanceLeaders,
TestTlogReplica, ZkFailoverTest, SimpleCollectionCreateDeleteTest,
TestLocalFSCloudBackupRestore]
[junit4] Completed [534/837 (2!)] on J1 in 12.96s, 1 test, 1 failure <<<
FAILURES!
[...truncated 10894 lines...]
check-licenses:
[echo] License check under:
/home/jenkins/workspace/Lucene-Solr-http2-Linux/lucene
[licenses] MISSING sha1 checksum file for:
/home/jenkins/workspace/Lucene-Solr-http2-Linux/lucene/replicator/lib/jetty-continuation-9.4.14.v20181114.jar
[licenses] EXPECTED sha1 checksum file :
/home/jenkins/workspace/Lucene-Solr-http2-Linux/lucene/licenses/jetty-continuation-9.4.14.v20181114.jar.sha1
[licenses] MISSING sha1 checksum file for:
/home/jenkins/workspace/Lucene-Solr-http2-Linux/lucene/replicator/lib/jetty-http-9.4.14.v20181114.jar
[licenses] EXPECTED sha1 checksum file :
/home/jenkins/workspace/Lucene-Solr-http2-Linux/lucene/licenses/jetty-http-9.4.14.v20181114.jar.sha1
[licenses] MISSING sha1 checksum file for:
/home/jenkins/workspace/Lucene-Solr-http2-Linux/lucene/replicator/lib/jetty-io-9.4.14.v20181114.jar
[licenses] EXPECTED sha1 checksum file :
/home/jenkins/workspace/Lucene-Solr-http2-Linux/lucene/licenses/jetty-io-9.4.14.v20181114.jar.sha1
[licenses] MISSING sha1 checksum file for:
/home/jenkins/workspace/Lucene-Solr-http2-Linux/lucene/replicator/lib/jetty-server-9.4.14.v20181114.jar
[licenses] EXPECTED sha1 checksum file :
/home/jenkins/workspace/Lucene-Solr-http2-Linux/lucene/licenses/jetty-server-9.4.14.v20181114.jar.sha1
[licenses] MISSING sha1 checksum file for:
/home/jenkins/workspace/Lucene-Solr-http2-Linux/lucene/replicator/lib/jetty-servlet-9.4.14.v20181114.jar
[licenses] EXPECTED sha1 checksum file :
/home/jenkins/workspace/Lucene-Solr-http2-Linux/lucene/licenses/jetty-servlet-9.4.14.v20181114.jar.sha1
[...truncated 3 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-http2-Linux/build.xml:633: The following
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-http2-Linux/build.xml:117: The following
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-http2-Linux/lucene/build.xml:90: The
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-http2-Linux/lucene/tools/custom-tasks.xml:62:
License check failed. Check the logs.
If you recently modified ivy-versions.properties or any module's ivy.xml,
make sure you run "ant clean-jars jar-checksums" before running precommit.
Total time: 79 minutes 4 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Setting
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Setting
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
Setting
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
