Build: https://ci-builds.apache.org/job/Solr/job/Solr-Smoketest-9.8/109/

Log: 
[...truncated 6.03 MiB...]
  2> 1470073 INFO  (qtp1321512416-20584-null-22463) [n:127.0.0.1:38867_solr c: 
s: r: x:pull_replica_test_create_delete_shard2_replica_n5 t:null-22463] 
o.a.s.c.SolrCore CLOSING SolrCore org.apache.solr.core.SolrCore@60dfc6f8 
pull_replica_test_create_delete_shard2_replica_n5
  2> 1470073 INFO  (qtp1321512416-20584-null-22463) [n:127.0.0.1:38867_solr c: 
s: r: x:pull_replica_test_create_delete_shard2_replica_n5 t:null-22463] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.pull_replica_test_create_delete.shard2.replica_n5 
tag=SolrCore@60dfc6f8
  2> 1470073 INFO  (qtp1321512416-20585-null-22463) [n:127.0.0.1:38867_solr c: 
s: r: x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22463] 
o.a.s.c.SolrCore CLOSING SolrCore org.apache.solr.core.SolrCore@26ee2307 
pull_replica_test_create_delete_shard2_replica_p3
  2> 1470073 INFO  (qtp1321512416-20584-null-22463) [n:127.0.0.1:38867_solr c: 
s: r: x:pull_replica_test_create_delete_shard2_replica_n5 t:null-22463] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.pull_replica_test_create_delete.shard2.leader 
tag=SolrCore@60dfc6f8
  2> 1470073 INFO  (qtp1321512416-20585-null-22463) [n:127.0.0.1:38867_solr c: 
s: r: x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22463] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.pull_replica_test_create_delete.shard2.replica_p3 
tag=SolrCore@26ee2307
  2> 1470073 INFO  (qtp1321512416-20585-null-22463) [n:127.0.0.1:38867_solr c: 
s: r: x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22463] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.pull_replica_test_create_delete.shard2.leader 
tag=SolrCore@26ee2307
  2> 1470073 INFO  (qtp1321512416-20584-null-22463) [n:127.0.0.1:38867_solr c: 
s: r: x:pull_replica_test_create_delete_shard2_replica_n5 t:null-22463] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED 
(unnecessary).
  2> 1470073 INFO  (qtp1321512416-20585-null-22463) [n:127.0.0.1:38867_solr c: 
s: r: x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22463] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED 
(unnecessary).
  2> 1470073 INFO  (qtp1321512416-20586-null-22463) [n:127.0.0.1:38867_solr c: 
s: r: x:pull_replica_test_create_delete_shard1_replica_p8 t:null-22463] 
o.a.s.c.SolrCore CLOSING SolrCore org.apache.solr.core.SolrCore@141f971b 
pull_replica_test_create_delete_shard1_replica_p8
  2> 1470073 INFO  (qtp1321512416-20586-null-22463) [n:127.0.0.1:38867_solr c: 
s: r: x:pull_replica_test_create_delete_shard1_replica_p8 t:null-22463] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.pull_replica_test_create_delete.shard1.replica_p8 
tag=SolrCore@141f971b
  2> 1470073 INFO  (qtp1321512416-20586-null-22463) [n:127.0.0.1:38867_solr c: 
s: r: x:pull_replica_test_create_delete_shard1_replica_p8 t:null-22463] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.pull_replica_test_create_delete.shard1.leader 
tag=SolrCore@141f971b
  2> 1470073 INFO  (qtp1321512416-20586-null-22463) [n:127.0.0.1:38867_solr c: 
s: r: x:pull_replica_test_create_delete_shard1_replica_p8 t:null-22463] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED 
(unnecessary).
  2> 1470074 INFO  (qtp1321512416-20587-null-22463) [n:127.0.0.1:38867_solr c: 
s: r: x: t:null-22463] o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/pull_replica_test_create_delete/terms/shard1 to Terms{values={}, 
version=1} for removeTerm
  2> 1470075 INFO  (qtp68128679-20789-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22463] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.pull_replica_test_create_delete.shard1.replica_p4 tag=null
  2> 1470075 INFO  (qtp68128679-20789-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22463] 
o.a.s.c.ZkController pull_replica_test_create_delete_shard1_replica_p4 stopping 
background replication from leader
  2> 1470075 INFO  (qtp68128679-20785-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard1_replica_p7 t:null-22463] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.pull_replica_test_create_delete.shard1.replica_p7 tag=null
  2> 1470075 INFO  (qtp68128679-20785-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard1_replica_p7 t:null-22463] 
o.a.s.c.ZkController pull_replica_test_create_delete_shard1_replica_p7 stopping 
background replication from leader
  2> 1470075 INFO  (qtp68128679-20788-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard2_replica_p1 t:null-22463] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.pull_replica_test_create_delete.shard2.replica_p1 tag=null
  2> 1470076 INFO  (qtp68128679-20788-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard2_replica_p1 t:null-22463] 
o.a.s.c.ZkController pull_replica_test_create_delete_shard2_replica_p1 stopping 
background replication from leader
  2> 1470076 INFO  (qtp68128679-20784-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard2_replica_p2 t:null-22463] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.pull_replica_test_create_delete.shard2.replica_p2 tag=null
  2> 1470076 INFO  (qtp68128679-20784-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard2_replica_p2 t:null-22463] 
o.a.s.c.ZkController pull_replica_test_create_delete_shard2_replica_p2 stopping 
background replication from leader
  2> 1470076 INFO  (qtp68128679-20784-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard2_replica_p2 t:null-22463] 
o.a.s.c.SolrCore CLOSING SolrCore org.apache.solr.core.SolrCore@6376bde 
pull_replica_test_create_delete_shard2_replica_p2
  2> 1470076 INFO  (qtp68128679-20784-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard2_replica_p2 t:null-22463] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.pull_replica_test_create_delete.shard2.replica_p2 
tag=SolrCore@6376bde
  2> 1470076 INFO  (qtp68128679-20784-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard2_replica_p2 t:null-22463] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.pull_replica_test_create_delete.shard2.leader 
tag=SolrCore@6376bde
  2> 1470076 INFO  (qtp68128679-20784-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard2_replica_p2 t:null-22463] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED 
(unnecessary).
  2> 1470076 INFO  (qtp68128679-20788-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard2_replica_p1 t:null-22463] 
o.a.s.c.SolrCore CLOSING SolrCore org.apache.solr.core.SolrCore@9b09ee9 
pull_replica_test_create_delete_shard2_replica_p1
  2> 1470076 INFO  (qtp68128679-20788-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard2_replica_p1 t:null-22463] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.pull_replica_test_create_delete.shard2.replica_p1 
tag=SolrCore@9b09ee9
  2> 1470076 INFO  (qtp68128679-20788-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard2_replica_p1 t:null-22463] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.pull_replica_test_create_delete.shard2.leader 
tag=SolrCore@9b09ee9
  2> 1470076 INFO  (qtp68128679-20788-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard2_replica_p1 t:null-22463] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED 
(unnecessary).
  2> 1470076 INFO  (qtp68128679-20789-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22463] 
o.a.s.c.SolrCore CLOSING SolrCore org.apache.solr.core.SolrCore@1282d4a8 
pull_replica_test_create_delete_shard1_replica_p4
  2> 1470076 INFO  (qtp68128679-20789-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22463] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.pull_replica_test_create_delete.shard1.replica_p4 
tag=SolrCore@1282d4a8
  2> 1470076 INFO  (qtp68128679-20789-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22463] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.pull_replica_test_create_delete.shard1.leader 
tag=SolrCore@1282d4a8
  2> 1470077 INFO  (qtp68128679-20789-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22463] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED 
(unnecessary).
  2> 1470078 INFO  (zkCallback-12639-thread-1) [n: c: s: r: x: t:] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_create_delete/state.json zxid: 3256] for 
collection [pull_replica_test_create_delete] has occurred - updating... (live 
nodes size: [2])
  2> 1470078 INFO  (qtp1321512416-20587-null-22463) [n:127.0.0.1:38867_solr c: 
s: r: x: t:null-22463] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/admin/cores 
params={deleteInstanceDir=true&core=pull_replica_test_create_delete_shard1_replica_n6&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
 status=0 QTime=6
  2> 1470079 INFO  (qtp68128679-20785-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard1_replica_p7 t:null-22463] 
o.a.s.c.SolrCore CLOSING SolrCore org.apache.solr.core.SolrCore@65cdf189 
pull_replica_test_create_delete_shard1_replica_p7
  2> 1470079 INFO  (qtp68128679-20785-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard1_replica_p7 t:null-22463] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.pull_replica_test_create_delete.shard1.replica_p7 
tag=SolrCore@65cdf189
  2> 1470079 INFO  (qtp68128679-20785-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard1_replica_p7 t:null-22463] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.pull_replica_test_create_delete.shard1.leader 
tag=SolrCore@65cdf189
  2> 1470079 INFO  (qtp68128679-20785-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard1_replica_p7 t:null-22463] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED 
(unnecessary).
  2> 1470079 INFO  (zkCallback-12785-thread-1) [n: c: s: r: x: t:] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_create_delete/state.json zxid: 3256] for 
collection [pull_replica_test_create_delete] has occurred - updating... (live 
nodes size: [2])
  2> 1470081 INFO  (qtp1321512416-20585-null-22463) [n:127.0.0.1:38867_solr c: 
s: r: x: t:null-22463] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/admin/cores 
params={deleteInstanceDir=true&core=pull_replica_test_create_delete_shard2_replica_p3&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
 status=0 QTime=8
  2> 1470082 INFO  (qtp68128679-20789-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x: t:null-22463] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={deleteInstanceDir=true&core=pull_replica_test_create_delete_shard1_replica_p4&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
 status=0 QTime=7
  2> 1470082 INFO  (zkCallback-12785-thread-1) [n: c: s: r: x: t:] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_create_delete/state.json zxid: 3257] for 
collection [pull_replica_test_create_delete] has occurred - updating... (live 
nodes size: [2])
  2> 1470086 INFO  (qtp1321512416-20586-null-22463) [n:127.0.0.1:38867_solr c: 
s: r: x: t:null-22463] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/admin/cores 
params={deleteInstanceDir=true&core=pull_replica_test_create_delete_shard1_replica_p8&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
 status=0 QTime=14
  2> 1470088 INFO  (qtp1321512416-20584-null-22463) [n:127.0.0.1:38867_solr c: 
s: r: x: t:null-22463] o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/pull_replica_test_create_delete/terms/shard2 to Terms{values={}, 
version=1} for removeTerm
  2> 1470090 INFO  (qtp1321512416-20584-null-22463) [n:127.0.0.1:38867_solr c: 
s: r: x: t:null-22463] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/admin/cores 
params={deleteInstanceDir=true&core=pull_replica_test_create_delete_shard2_replica_n5&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
 status=0 QTime=17
  2> 1470092 INFO  (qtp68128679-20784-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x: t:null-22463] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={deleteInstanceDir=true&core=pull_replica_test_create_delete_shard2_replica_p2&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
 status=0 QTime=16
  2> 1470095 INFO  (qtp68128679-20788-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x: t:null-22463] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={deleteInstanceDir=true&core=pull_replica_test_create_delete_shard2_replica_p1&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
 status=0 QTime=19
  2> 1470098 INFO  (qtp68128679-20785-null-22463) [n:127.0.0.1:44527_solr c: s: 
r: x: t:null-22463] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={deleteInstanceDir=true&core=pull_replica_test_create_delete_shard1_replica_p7&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
 status=0 QTime=23
  2> 1470100 INFO  
(DistributedCollectionApiCommandExecutor-12660-thread-5-processing-127.0.0.1:38867_solr
 null-22463 pull_replica_test_create_delete) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s: r: x: t:null-22463] 
o.a.s.c.c.ZkStateReader /collections/pull_replica_test_create_delete/state.json 
is deleted, stop watching children
  2> 1470306 INFO  (qtp1321512416-20583-null-22463) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s: r: x: t:null-22463] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/collections 
params={name=pull_replica_test_create_delete&action=DELETE&wt=javabin&version=2}
 status=0 QTime=238
  2> 1470306 INFO  
(TEST-TestPullReplica.testCreateDelete-seed#[BEBFAFD58271AED0]) 
[n:127.0.0.1:38867_solr c: s: r: x: t:] o.a.s.c.TestPullReplica Collection 
deleted
  2> 1470306 INFO  
(TEST-TestPullReplica.testCreateDelete-seed#[BEBFAFD58271AED0]) 
[n:127.0.0.1:38867_solr c: s: r: x: t:] o.a.s.c.SolrCloudTestCase waitForState 
(pull_replica_test_create_delete): Waiting for collection 
pull_replica_test_create_delete to be deleted
  2> 1470307 INFO  
(TEST-TestPullReplica.testCreateDelete-seed#[BEBFAFD58271AED0]) 
[n:127.0.0.1:38867_solr c: s: r: x: t:] o.a.s.c.c.ZkStateReader 
/collections/pull_replica_test_create_delete/state.json is deleted, stop 
watching children
  2> 1470308 INFO  
(TEST-TestPullReplica.testCreateDelete-seed#[BEBFAFD58271AED0]) 
[n:127.0.0.1:38867_solr c: s: r: x: t:] o.a.s.SolrTestCaseJ4 ###Ending 
testCreateDelete {seed=[BEBFAFD58271AED0:32B61E4179FFB1D7]}
  2> 1470338 INFO  
(TEST-TestPullReplica.testCreateDelete-seed#[BEBFAFD58271AED0]) 
[n:127.0.0.1:38867_solr c: s: r: x: t:] o.a.s.SolrTestCaseJ4 ###Starting 
testCreateDelete {seed=[BEBFAFD58271AED0:62D128BA1F2D1179]}
  2> 1470344 INFO  (qtp68128679-20789-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s: r: x: t:null-22464] 
o.a.s.c.a.c.DistributedCollectionConfigSetCommandRunner Running Collection API 
locally for CREATE asyncId=null
  2> 1470348 INFO  
(DistributedCollectionApiCommandExecutor-12790-thread-5-processing-127.0.0.1:44527_solr
 null-22464 pull_replica_test_create_delete) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s: r: x: t:null-22464] 
o.a.s.c.a.c.CreateCollectionCmd Create collection 
pull_replica_test_create_delete
  2> 1470351 WARN  
(DistributedCollectionApiCommandExecutor-12790-thread-5-processing-127.0.0.1:44527_solr
 null-22464 pull_replica_test_create_delete) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s: r: x: t:null-22464] 
o.a.s.c.a.c.CreateCollectionCmd Specified number of replicas of 4 on collection 
pull_replica_test_create_delete is higher than the number of Solr instances 
currently live or live and part of your createNodeSet(2). It's unusual to run 
two replica of the same slice on the same Solr-instance.
  2> 1470360 INFO  
(DistributedCollectionApiCommandExecutor-12790-thread-5-processing-127.0.0.1:44527_solr
 null-22464 pull_replica_test_create_delete) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s: r: x: t:null-22464] o.a.s.c.o.SliceMutator 
createReplica() {
  2>   "core":"pull_replica_test_create_delete_shard2_replica_n1",
  2>   "node_name":"127.0.0.1:38867_solr",
  2>   "base_url":"https://127.0.0.1:38867/solr";,
  2>   "collection":"pull_replica_test_create_delete",
  2>   "shard":"shard2",
  2>   "state":"down",
  2>   "type":"NRT",
  2>   "operation":"ADDREPLICA",
  2>   "waitForFinalState":"false"} 
  2> 1470361 INFO  
(DistributedCollectionApiCommandExecutor-12790-thread-5-processing-127.0.0.1:44527_solr
 null-22464 pull_replica_test_create_delete) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s: r: x: t:null-22464] o.a.s.c.o.SliceMutator 
createReplica() {
  2>   "core":"pull_replica_test_create_delete_shard1_replica_p2",
  2>   "node_name":"127.0.0.1:38867_solr",
  2>   "base_url":"https://127.0.0.1:38867/solr";,
  2>   "collection":"pull_replica_test_create_delete",
  2>   "shard":"shard1",
  2>   "state":"down",
  2>   "type":"PULL",
  2>   "operation":"ADDREPLICA",
  2>   "waitForFinalState":"false"} 
  2> 1470362 INFO  
(DistributedCollectionApiCommandExecutor-12790-thread-5-processing-127.0.0.1:44527_solr
 null-22464 pull_replica_test_create_delete) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s: r: x: t:null-22464] o.a.s.c.o.SliceMutator 
createReplica() {
  2>   "core":"pull_replica_test_create_delete_shard2_replica_p3",
  2>   "node_name":"127.0.0.1:38867_solr",
  2>   "base_url":"https://127.0.0.1:38867/solr";,
  2>   "collection":"pull_replica_test_create_delete",
  2>   "shard":"shard2",
  2>   "state":"down",
  2>   "type":"PULL",
  2>   "operation":"ADDREPLICA",
  2>   "waitForFinalState":"false"} 
  2> 1470363 INFO  
(DistributedCollectionApiCommandExecutor-12790-thread-5-processing-127.0.0.1:44527_solr
 null-22464 pull_replica_test_create_delete) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s: r: x: t:null-22464] o.a.s.c.o.SliceMutator 
createReplica() {
  2>   "core":"pull_replica_test_create_delete_shard1_replica_p4",
  2>   "node_name":"127.0.0.1:44527_solr",
  2>   "base_url":"https://127.0.0.1:44527/solr";,
  2>   "collection":"pull_replica_test_create_delete",
  2>   "shard":"shard1",
  2>   "state":"down",
  2>   "type":"PULL",
  2>   "operation":"ADDREPLICA",
  2>   "waitForFinalState":"false"} 
  2> 1470364 INFO  
(DistributedCollectionApiCommandExecutor-12790-thread-5-processing-127.0.0.1:44527_solr
 null-22464 pull_replica_test_create_delete) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s: r: x: t:null-22464] o.a.s.c.o.SliceMutator 
createReplica() {
  2>   "core":"pull_replica_test_create_delete_shard2_replica_p5",
  2>   "node_name":"127.0.0.1:44527_solr",
  2>   "base_url":"https://127.0.0.1:44527/solr";,
  2>   "collection":"pull_replica_test_create_delete",
  2>   "shard":"shard2",
  2>   "state":"down",
  2>   "type":"PULL",
  2>   "operation":"ADDREPLICA",
  2>   "waitForFinalState":"false"} 
  2> 1470365 INFO  
(DistributedCollectionApiCommandExecutor-12790-thread-5-processing-127.0.0.1:44527_solr
 null-22464 pull_replica_test_create_delete) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s: r: x: t:null-22464] o.a.s.c.o.SliceMutator 
createReplica() {
  2>   "core":"pull_replica_test_create_delete_shard1_replica_p6",
  2>   "node_name":"127.0.0.1:44527_solr",
  2>   "base_url":"https://127.0.0.1:44527/solr";,
  2>   "collection":"pull_replica_test_create_delete",
  2>   "shard":"shard1",
  2>   "state":"down",
  2>   "type":"PULL",
  2>   "operation":"ADDREPLICA",
  2>   "waitForFinalState":"false"} 
  2> 1470366 INFO  
(DistributedCollectionApiCommandExecutor-12790-thread-5-processing-127.0.0.1:44527_solr
 null-22464 pull_replica_test_create_delete) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s: r: x: t:null-22464] o.a.s.c.o.SliceMutator 
createReplica() {
  2>   "core":"pull_replica_test_create_delete_shard1_replica_n7",
  2>   "node_name":"127.0.0.1:38867_solr",
  2>   "base_url":"https://127.0.0.1:38867/solr";,
  2>   "collection":"pull_replica_test_create_delete",
  2>   "shard":"shard1",
  2>   "state":"down",
  2>   "type":"NRT",
  2>   "operation":"ADDREPLICA",
  2>   "waitForFinalState":"false"} 
  2> 1470367 INFO  
(DistributedCollectionApiCommandExecutor-12790-thread-5-processing-127.0.0.1:44527_solr
 null-22464 pull_replica_test_create_delete) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s: r: x: t:null-22464] o.a.s.c.o.SliceMutator 
createReplica() {
  2>   "core":"pull_replica_test_create_delete_shard2_replica_p8",
  2>   "node_name":"127.0.0.1:44527_solr",
  2>   "base_url":"https://127.0.0.1:44527/solr";,
  2>   "collection":"pull_replica_test_create_delete",
  2>   "shard":"shard2",
  2>   "state":"down",
  2>   "type":"PULL",
  2>   "operation":"ADDREPLICA",
  2>   "waitForFinalState":"false"} 
  2> 1470371 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr c: 
s: r: x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&collection=pull_replica_test_create_delete&version=2&replicaType=NRT&coreNodeName=core_node9&name=pull_replica_test_create_delete_shard2_replica_n1&action=CREATE&numShards=2&shard=shard2&wt=javabin
  2> 1470371 INFO  (qtp1321512416-20890-null-22464) [n:127.0.0.1:38867_solr c: 
s: r: x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&collection=pull_replica_test_create_delete&version=2&replicaType=PULL&coreNodeName=core_node10&name=pull_replica_test_create_delete_shard1_replica_p2&action=CREATE&numShards=2&shard=shard1&wt=javabin
  2> 1470371 INFO  (qtp1321512416-20587-null-22464) [n:127.0.0.1:38867_solr c: 
s: r: x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22464] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&collection=pull_replica_test_create_delete&version=2&replicaType=PULL&coreNodeName=core_node11&name=pull_replica_test_create_delete_shard2_replica_p3&action=CREATE&numShards=2&shard=shard2&wt=javabin
  2> 1470372 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr c: 
s: r: x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&collection=pull_replica_test_create_delete&version=2&replicaType=NRT&coreNodeName=core_node15&name=pull_replica_test_create_delete_shard1_replica_n7&action=CREATE&numShards=2&shard=shard1&wt=javabin
  2> 1470372 INFO  (qtp68128679-20788-null-22464) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&collection=pull_replica_test_create_delete&version=2&replicaType=PULL&coreNodeName=core_node12&name=pull_replica_test_create_delete_shard1_replica_p4&action=CREATE&numShards=2&shard=shard1&wt=javabin
  2> 1470372 INFO  (qtp68128679-20785-null-22464) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard2_replica_p5 t:null-22464] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&collection=pull_replica_test_create_delete&version=2&replicaType=PULL&coreNodeName=core_node13&name=pull_replica_test_create_delete_shard2_replica_p5&action=CREATE&numShards=2&shard=shard2&wt=javabin
  2> 1470373 INFO  (qtp68128679-20787-null-22464) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&collection=pull_replica_test_create_delete&version=2&replicaType=PULL&coreNodeName=core_node14&name=pull_replica_test_create_delete_shard1_replica_p6&action=CREATE&numShards=2&shard=shard1&wt=javabin
  2> 1470374 INFO  (qtp68128679-20786-null-22464) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard2_replica_p8 t:null-22464] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&collection=pull_replica_test_create_delete&version=2&replicaType=PULL&coreNodeName=core_node16&name=pull_replica_test_create_delete_shard2_replica_p8&action=CREATE&numShards=2&shard=shard2&wt=javabin
  2> 1470384 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.11.1
  2> 1470385 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.s.IndexSchema Schema name=minimal
  2> 1470385 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.s.IndexSchema Loaded schema minimal/1.7 with uniqueid field id
  2> 1470385 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.c.CoreContainer Creating SolrCore 
'pull_replica_test_create_delete_shard1_replica_n7' using configuration from 
configset conf, trusted=true
  2> 1470385 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.c.SolrCore Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.TestPullReplica_BEBFAFD58271AED0-001/tempDir-001/node1/pull_replica_test_create_delete_shard1_replica_n7],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.TestPullReplica_BEBFAFD58271AED0-001/tempDir-001/node1/pull_replica_test_create_delete_shard1_replica_n7/data/]
  2> 1470386 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node9 
x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.11.1
  2> 1470387 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node9 
x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.s.IndexSchema Schema name=minimal
  2> 1470387 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node9 
x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.s.IndexSchema Loaded schema minimal/1.7 with uniqueid field id
  2> 1470387 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node9 
x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.c.CoreContainer Creating SolrCore 
'pull_replica_test_create_delete_shard2_replica_n1' using configuration from 
configset conf, trusted=true
  2> 1470387 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node9 
x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.c.SolrCore Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.TestPullReplica_BEBFAFD58271AED0-001/tempDir-001/node1/pull_replica_test_create_delete_shard2_replica_n1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.TestPullReplica_BEBFAFD58271AED0-001/tempDir-001/node1/pull_replica_test_create_delete_shard2_replica_n1/data/]
  2> 1470390 INFO  (qtp1321512416-20890-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node10 
x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.11.1
  2> 1470391 INFO  (qtp1321512416-20890-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node10 
x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.s.IndexSchema Schema name=minimal
  2> 1470391 INFO  (qtp1321512416-20890-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node10 
x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.s.IndexSchema Loaded schema minimal/1.7 with uniqueid field id
  2> 1470391 INFO  (qtp1321512416-20890-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node10 
x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.c.CoreContainer Creating SolrCore 
'pull_replica_test_create_delete_shard1_replica_p2' using configuration from 
configset conf, trusted=true
  2> 1470391 INFO  (qtp1321512416-20890-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node10 
x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.c.SolrCore Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.TestPullReplica_BEBFAFD58271AED0-001/tempDir-001/node1/pull_replica_test_create_delete_shard1_replica_p2],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.TestPullReplica_BEBFAFD58271AED0-001/tempDir-001/node1/pull_replica_test_create_delete_shard1_replica_p2/data/]
  2> 1470393 INFO  (qtp1321512416-20587-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node11 
x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22464] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.11.1
  2> 1470393 INFO  (qtp1321512416-20587-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node11 
x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22464] 
o.a.s.s.IndexSchema Schema name=minimal
  2> 1470393 INFO  (qtp1321512416-20587-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node11 
x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22464] 
o.a.s.s.IndexSchema Loaded schema minimal/1.7 with uniqueid field id
  2> 1470393 INFO  (qtp1321512416-20587-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node11 
x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22464] 
o.a.s.c.CoreContainer Creating SolrCore 
'pull_replica_test_create_delete_shard2_replica_p3' using configuration from 
configset conf, trusted=true
  2> 1470394 INFO  (qtp1321512416-20587-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node11 
x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22464] 
o.a.s.c.SolrCore Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.TestPullReplica_BEBFAFD58271AED0-001/tempDir-001/node1/pull_replica_test_create_delete_shard2_replica_p3],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.TestPullReplica_BEBFAFD58271AED0-001/tempDir-001/node1/pull_replica_test_create_delete_shard2_replica_p3/data/]
  2> 1470417 INFO  (qtp68128679-20786-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node16 
x:pull_replica_test_create_delete_shard2_replica_p8 t:null-22464] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.11.1
  2> 1470418 INFO  (qtp68128679-20786-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node16 
x:pull_replica_test_create_delete_shard2_replica_p8 t:null-22464] 
o.a.s.s.IndexSchema Schema name=minimal
  2> 1470418 INFO  (qtp68128679-20786-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node16 
x:pull_replica_test_create_delete_shard2_replica_p8 t:null-22464] 
o.a.s.s.IndexSchema Loaded schema minimal/1.7 with uniqueid field id
  2> 1470418 INFO  (qtp68128679-20786-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node16 
x:pull_replica_test_create_delete_shard2_replica_p8 t:null-22464] 
o.a.s.c.CoreContainer Creating SolrCore 
'pull_replica_test_create_delete_shard2_replica_p8' using configuration from 
configset conf, trusted=true
  2> 1470418 INFO  (qtp68128679-20786-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node16 
x:pull_replica_test_create_delete_shard2_replica_p8 t:null-22464] 
o.a.s.c.SolrCore Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.TestPullReplica_BEBFAFD58271AED0-001/tempDir-001/node2/pull_replica_test_create_delete_shard2_replica_p8],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.TestPullReplica_BEBFAFD58271AED0-001/tempDir-001/node2/pull_replica_test_create_delete_shard2_replica_p8/data/]
  2> 1470420 INFO  (qtp68128679-20788-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node12 
x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.11.1
  2> 1470421 INFO  (qtp68128679-20788-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node12 
x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.s.IndexSchema Schema name=minimal
  2> 1470421 INFO  (qtp68128679-20788-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node12 
x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.s.IndexSchema Loaded schema minimal/1.7 with uniqueid field id
  2> 1470421 INFO  (qtp68128679-20788-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node12 
x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.c.CoreContainer Creating SolrCore 
'pull_replica_test_create_delete_shard1_replica_p4' using configuration from 
configset conf, trusted=true
  2> 1470421 INFO  (qtp68128679-20788-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node12 
x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.c.SolrCore Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.TestPullReplica_BEBFAFD58271AED0-001/tempDir-001/node2/pull_replica_test_create_delete_shard1_replica_p4],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.TestPullReplica_BEBFAFD58271AED0-001/tempDir-001/node2/pull_replica_test_create_delete_shard1_replica_p4/data/]
  2> 1470423 INFO  (qtp68128679-20785-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node13 
x:pull_replica_test_create_delete_shard2_replica_p5 t:null-22464] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.11.1
  2> 1470424 INFO  (qtp68128679-20785-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node13 
x:pull_replica_test_create_delete_shard2_replica_p5 t:null-22464] 
o.a.s.s.IndexSchema Schema name=minimal
  2> 1470424 INFO  (qtp68128679-20785-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node13 
x:pull_replica_test_create_delete_shard2_replica_p5 t:null-22464] 
o.a.s.s.IndexSchema Loaded schema minimal/1.7 with uniqueid field id
  2> 1470424 INFO  (qtp68128679-20785-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node13 
x:pull_replica_test_create_delete_shard2_replica_p5 t:null-22464] 
o.a.s.c.CoreContainer Creating SolrCore 
'pull_replica_test_create_delete_shard2_replica_p5' using configuration from 
configset conf, trusted=true
  2> 1470425 INFO  (qtp68128679-20785-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node13 
x:pull_replica_test_create_delete_shard2_replica_p5 t:null-22464] 
o.a.s.c.SolrCore Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.TestPullReplica_BEBFAFD58271AED0-001/tempDir-001/node2/pull_replica_test_create_delete_shard2_replica_p5],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.TestPullReplica_BEBFAFD58271AED0-001/tempDir-001/node2/pull_replica_test_create_delete_shard2_replica_p5/data/]
  2> 1470426 INFO  (qtp68128679-20787-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node14 
x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.11.1
  2> 1470427 INFO  (qtp68128679-20787-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node14 
x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.s.IndexSchema Schema name=minimal
  2> 1470427 INFO  (qtp68128679-20787-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node14 
x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.s.IndexSchema Loaded schema minimal/1.7 with uniqueid field id
  2> 1470427 INFO  (qtp68128679-20787-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node14 
x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.c.CoreContainer Creating SolrCore 
'pull_replica_test_create_delete_shard1_replica_p6' using configuration from 
configset conf, trusted=true
  2> 1470427 INFO  (qtp68128679-20787-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node14 
x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.c.SolrCore Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.TestPullReplica_BEBFAFD58271AED0-001/tempDir-001/node2/pull_replica_test_create_delete_shard1_replica_p6],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.TestPullReplica_BEBFAFD58271AED0-001/tempDir-001/node2/pull_replica_test_create_delete_shard1_replica_p6/data/]
  2> 1470440 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
  2> 1470440 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10
  2> 1470440 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
  2> 1470440 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
  2> 1470442 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
  2> 1470442 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
  2> 1470442 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
  2> 1470445 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/pull_replica_test_create_delete/terms/shard1 to 
Terms{values={core_node15=0}, version=0} for registerTerm
  2> 1470445 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/pull_replica_test_create_delete/leaders/shard1
  2> 1470447 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
  2> 1470448 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
  2> 1470448 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.c.SyncStrategy Sync replicas to 
https://127.0.0.1:38867/solr/pull_replica_test_create_delete_shard1_replica_n7/
  2> 1470448 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
  2> 1470448 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.c.SyncStrategy 
https://127.0.0.1:38867/solr/pull_replica_test_create_delete_shard1_replica_n7/ 
has no replicas
  2> 1470448 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/pull_replica_test_create_delete/leaders/shard1/leader after 
winning as 
/collections/pull_replica_test_create_delete/leader_elect/shard1/election/72097308771876869-core_node15-n_0000000000
  2> 1470450 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:38867/solr/pull_replica_test_create_delete_shard1_replica_n7/ 
shard1
  2> 1470450 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.c.ZkController I am the leader, no recovery necessary
  2> 1470451 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.c.ZkController No registered searcher found for core: 
pull_replica_test_create_delete_shard1_replica_n7, waiting until a searcher is 
registered before publishing as active
  2> 1470451 INFO  
(searcherExecutor-15257-thread-1-processing-pull_replica_test_create_delete_shard1_replica_n7
 null-22464 core_node15 127.0.0.1:38867_solr pull_replica_test_create_delete 
shard1) [n:127.0.0.1:38867_solr c:pull_replica_test_create_delete s:shard1 
r:core_node15 x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.c.SolrCore Registered new searcher autowarm time: 0 ms
  2> 1470451 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22464] 
o.a.s.c.ZkController Found a registered searcher: 
Searcher@15d84cf3[pull_replica_test_create_delete_shard1_replica_n7] 
main{UninvertingDirectoryReader()}, took: 0.0 ms for core: 
pull_replica_test_create_delete_shard1_replica_n7, id: 
org.apache.solr.core.SolrCore@b39287e 
pull_replica_test_create_delete_shard1_replica_n7
  2> 1470453 INFO  (qtp1321512416-20585-null-22464) [n:127.0.0.1:38867_solr c: 
s: r: x: t:null-22464] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node15&collection.configName=conf&newCollection=true&name=pull_replica_test_create_delete_shard1_replica_n7&action=CREATE&numShards=2&collection=pull_replica_test_create_delete&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=81
  2> 1470466 INFO  (qtp68128679-20788-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node12 
x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
  2> 1470466 INFO  (qtp68128679-20788-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node12 
x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
  2> 1470467 INFO  (qtp68128679-20788-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node12 
x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
  2> 1470467 INFO  (qtp68128679-20788-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node12 
x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
  2> 1470468 INFO  (qtp68128679-20788-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node12 
x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
  2> 1470469 INFO  (qtp68128679-20788-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node12 
x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.c.ZkController pull_replica_test_create_delete_shard1_replica_p4 starting 
background replication from leader
  2> 1470470 INFO  (qtp68128679-20788-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node12 
x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.c.ReplicateFromLeader Will start replication from leader with poll 
interval: 00:00:01
  2> 1470470 INFO  
(searcherExecutor-15268-thread-1-processing-pull_replica_test_create_delete_shard1_replica_p4
 null-22464 core_node12 127.0.0.1:44527_solr pull_replica_test_create_delete 
shard1) [n:127.0.0.1:44527_solr c:pull_replica_test_create_delete s:shard1 
r:core_node12 x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.c.SolrCore Registered new searcher autowarm time: 0 ms
  2> 1470474 INFO  (qtp68128679-20786-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node16 
x:pull_replica_test_create_delete_shard2_replica_p8 t:null-22464] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
  2> 1470474 INFO  (qtp68128679-20786-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node16 
x:pull_replica_test_create_delete_shard2_replica_p8 t:null-22464] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
  2> 1470475 INFO  (qtp68128679-20786-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node16 
x:pull_replica_test_create_delete_shard2_replica_p8 t:null-22464] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
  2> 1470475 INFO  (qtp68128679-20786-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node16 
x:pull_replica_test_create_delete_shard2_replica_p8 t:null-22464] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
  2> 1470475 INFO  (qtp68128679-20786-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node16 
x:pull_replica_test_create_delete_shard2_replica_p8 t:null-22464] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
  2> 1470477 INFO  (qtp68128679-20786-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node16 
x:pull_replica_test_create_delete_shard2_replica_p8 t:null-22464] 
o.a.s.c.ZkController pull_replica_test_create_delete_shard2_replica_p8 starting 
background replication from leader
  2> 1470477 INFO  (qtp68128679-20786-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node16 
x:pull_replica_test_create_delete_shard2_replica_p8 t:null-22464] 
o.a.s.c.ReplicateFromLeader Will start replication from leader with poll 
interval: 00:00:01
  2> 1470478 INFO  
(searcherExecutor-15266-thread-1-processing-pull_replica_test_create_delete_shard2_replica_p8
 null-22464 core_node16 127.0.0.1:44527_solr pull_replica_test_create_delete 
shard2) [n:127.0.0.1:44527_solr c:pull_replica_test_create_delete s:shard2 
r:core_node16 x:pull_replica_test_create_delete_shard2_replica_p8 t:null-22464] 
o.a.s.c.SolrCore Registered new searcher autowarm time: 0 ms
  2> 1470480 INFO  (qtp68128679-20786-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node16 
x:pull_replica_test_create_delete_shard2_replica_p8 t:null-22464] 
o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
  2> 1470480 INFO  (qtp68128679-20786-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node16 
x:pull_replica_test_create_delete_shard2_replica_p8 t:null-22464] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
  2> 1470481 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node9 
x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
  2> 1470481 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node9 
x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10
  2> 1470481 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node9 
x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
  2> 1470481 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node9 
x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
  2> 1470485 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node9 
x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
  2> 1470485 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node9 
x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
  2> 1470485 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node9 
x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
  2> 1470487 INFO  
(searcherExecutor-15259-thread-1-processing-pull_replica_test_create_delete_shard2_replica_n1
 null-22464 core_node9 127.0.0.1:38867_solr pull_replica_test_create_delete 
shard2) [n:127.0.0.1:38867_solr c:pull_replica_test_create_delete s:shard2 
r:core_node9 x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.c.SolrCore Registered new searcher autowarm time: 0 ms
  2> 1470487 INFO  (qtp1321512416-20587-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node11 
x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22464] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
  2> 1470487 INFO  (qtp1321512416-20587-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node11 
x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22464] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
  2> 1470487 INFO  (qtp68128679-20788-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node12 
x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
  2> 1470487 INFO  (qtp68128679-20788-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node12 
x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
  2> 1470487 DEBUG (indexFetcher-15283-thread-1) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node12 
x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.h.ReplicationHandler Polling for index modifications
  2> 1470487 INFO  (qtp68128679-20785-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node13 
x:pull_replica_test_create_delete_shard2_replica_p5 t:null-22464] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
  2> 1470487 INFO  (qtp68128679-20785-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node13 
x:pull_replica_test_create_delete_shard2_replica_p5 t:null-22464] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
  2> 1470488 INFO  (zkCallback-12639-thread-1) [n: c: s: r: x: t:] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_create_delete/state.json zxid: 3354] for 
collection [pull_replica_test_create_delete] has occurred - updating... (live 
nodes size: [2])
  2> 1470488 INFO  (qtp68128679-20787-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node14 
x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
  2> 1470488 INFO  (qtp68128679-20787-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node14 
x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
  2> 1470488 INFO  (qtp1321512416-20890-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node10 
x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
  2> 1470488 INFO  (qtp1321512416-20890-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node10 
x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
  2> 1470488 INFO  (qtp1321512416-20587-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node11 
x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22464] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
  2> 1470490 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node9 
x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/pull_replica_test_create_delete/terms/shard2 to 
Terms{values={core_node9=0}, version=0} for registerTerm
  2> 1470490 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node9 
x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/pull_replica_test_create_delete/leaders/shard2
  2> 1470490 INFO  (qtp1321512416-20587-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node11 
x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22464] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
  2> 1470490 INFO  (qtp1321512416-20587-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node11 
x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22464] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
  2> 1470490 INFO  (qtp1321512416-20587-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node11 
x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22464] 
o.a.s.c.ZkController pull_replica_test_create_delete_shard2_replica_p3 starting 
background replication from leader
  2> 1470490 INFO  (qtp1321512416-20587-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node11 
x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22464] 
o.a.s.c.ReplicateFromLeader Will start replication from leader with poll 
interval: 00:00:01
  2> 1470490 INFO  (qtp1321512416-20890-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node10 
x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
  2> 1470491 INFO  (qtp1321512416-20890-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node10 
x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
  2> 1470491 INFO  (qtp1321512416-20890-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node10 
x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
  2> 1470492 INFO  (qtp1321512416-20890-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node10 
x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.c.ZkController pull_replica_test_create_delete_shard1_replica_p2 starting 
background replication from leader
  2> 1470492 INFO  (qtp1321512416-20890-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node10 
x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.c.ReplicateFromLeader Will start replication from leader with poll 
interval: 00:00:01
  2> 1470493 INFO  (qtp1321512416-20587-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node11 
x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22464] 
o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
  2> 1470493 INFO  (qtp1321512416-20587-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node11 
x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22464] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
  2> 1470493 INFO  (qtp1321512416-20587-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node11 
x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22464] 
o.a.s.c.ZkController No registered searcher found for core: 
pull_replica_test_create_delete_shard2_replica_p3, waiting until a searcher is 
registered before publishing as active
  2> 1470493 INFO  (zkCallback-12639-thread-1) [n: c: s: r: x: t:] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_create_delete/state.json zxid: 3357] for 
collection [pull_replica_test_create_delete] has occurred - updating... (live 
nodes size: [2])
  2> 1470494 INFO  
(searcherExecutor-15263-thread-1-processing-pull_replica_test_create_delete_shard2_replica_p3
 null-22464 core_node11 127.0.0.1:38867_solr pull_replica_test_create_delete 
shard2) [n:127.0.0.1:38867_solr c:pull_replica_test_create_delete s:shard2 
r:core_node11 x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22464] 
o.a.s.c.SolrCore Registered new searcher autowarm time: 0 ms
  2> 1470494 INFO  (qtp1321512416-20587-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node11 
x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22464] 
o.a.s.c.ZkController Found a registered searcher: 
Searcher@285a8203[pull_replica_test_create_delete_shard2_replica_p3] 
main{UninvertingDirectoryReader()}, took: 1.0 ms for core: 
pull_replica_test_create_delete_shard2_replica_p3, id: 
org.apache.solr.core.SolrCore@399bae1c 
pull_replica_test_create_delete_shard2_replica_p3
  2> 1470494 INFO  
(searcherExecutor-15261-thread-1-processing-pull_replica_test_create_delete_shard1_replica_p2
 null-22464 core_node10 127.0.0.1:38867_solr pull_replica_test_create_delete 
shard1) [n:127.0.0.1:38867_solr c:pull_replica_test_create_delete s:shard1 
r:core_node10 x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.c.SolrCore Registered new searcher autowarm time: 0 ms
  2> 1470496 INFO  (zkCallback-12639-thread-1) [n: c: s: r: x: t:] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_create_delete/state.json zxid: 3360] for 
collection [pull_replica_test_create_delete] has occurred - updating... (live 
nodes size: [2])
  2> 1470496 INFO  (zkCallback-12785-thread-5) [n: c: s: r: x: t:] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_create_delete/state.json zxid: 3360] for 
collection [pull_replica_test_create_delete] has occurred - updating... (live 
nodes size: [2])
  2> 1470497 INFO  (qtp68128679-20786-null-22464) [n:127.0.0.1:44527_solr c: s: 
r: x: t:null-22464] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node16&collection.configName=conf&newCollection=true&name=pull_replica_test_create_delete_shard2_replica_p8&action=CREATE&numShards=2&collection=pull_replica_test_create_delete&shard=shard2&wt=javabin&version=2&replicaType=PULL}
 status=0 QTime=123
  2> 1470497 DEBUG (indexFetcher-15303-thread-1) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node11 
x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22464] 
o.a.s.h.ReplicationHandler Polling for index modifications
  2> 1470497 INFO  (qtp1321512416-20890-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node10 
x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
  2> 1470497 INFO  (qtp1321512416-20890-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node10 
x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
  2> 1470497 DEBUG (indexFetcher-15305-thread-1) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node10 
x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.h.ReplicationHandler Polling for index modifications
  2> 1470497 INFO  (indexFetcher-15305-thread-1) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node10 
x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.h.IndexFetcher Updated leaderUrl to 
https://127.0.0.1:38867/solr/pull_replica_test_create_delete_shard1_replica_n7/
  2> 1470497 INFO  (qtp1321512416-20586-null-22465) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22465] 
o.a.s.c.S.Request webapp=/solr path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
  2> 1470498 INFO  (qtp68128679-20787-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node14 
x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
  2> 1470499 INFO  (qtp1321512416-20587-null-22464) [n:127.0.0.1:38867_solr c: 
s: r: x: t:null-22464] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node11&collection.configName=conf&newCollection=true&name=pull_replica_test_create_delete_shard2_replica_p3&action=CREATE&numShards=2&collection=pull_replica_test_create_delete&shard=shard2&wt=javabin&version=2&replicaType=PULL}
 status=0 QTime=127
  2> 1470500 INFO  (qtp68128679-20787-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node14 
x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
  2> 1470500 INFO  (qtp68128679-20787-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node14 
x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
  2> 1470500 INFO  (qtp68128679-20787-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node14 
x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.c.ZkController pull_replica_test_create_delete_shard1_replica_p6 starting 
background replication from leader
  2> 1470500 INFO  (qtp68128679-20787-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node14 
x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.c.ReplicateFromLeader Will start replication from leader with poll 
interval: 00:00:01
  2> 1470500 INFO  
(searcherExecutor-15272-thread-1-processing-pull_replica_test_create_delete_shard1_replica_p6
 null-22464 core_node14 127.0.0.1:44527_solr pull_replica_test_create_delete 
shard1) [n:127.0.0.1:44527_solr c:pull_replica_test_create_delete s:shard1 
r:core_node14 x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.c.SolrCore Registered new searcher autowarm time: 0 ms
  2> 1470500 INFO  (indexFetcher-15305-thread-1) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node10 
x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.h.IndexFetcher Leader's generation: 1
  2> 1470501 INFO  (indexFetcher-15305-thread-1) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node10 
x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.h.IndexFetcher Leader's version: 0
  2> 1470501 INFO  (indexFetcher-15305-thread-1) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node10 
x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.h.IndexFetcher Follower's generation: 1
  2> 1470501 INFO  (indexFetcher-15305-thread-1) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node10 
x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.h.IndexFetcher Follower's version: 0
  2> 1470501 DEBUG (indexFetcher-15305-thread-1) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node10 
x:pull_replica_test_create_delete_shard1_replica_p2 t:null-22464] 
o.a.s.h.IndexFetcher Nothing to replicate, leader's version is 0
  2> 1470501 INFO  (qtp68128679-20787-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node14 
x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
  2> 1470501 INFO  (qtp68128679-20787-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node14 
x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
  2> 1470501 INFO  (zkCallback-12639-thread-1) [n: c: s: r: x: t:] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_create_delete/state.json zxid: 3363] for 
collection [pull_replica_test_create_delete] has occurred - updating... (live 
nodes size: [2])
  2> 1470502 INFO  (qtp68128679-20785-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node13 
x:pull_replica_test_create_delete_shard2_replica_p5 t:null-22464] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
  2> 1470502 INFO  (zkCallback-12785-thread-5) [n: c: s: r: x: t:] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_create_delete/state.json zxid: 3363] for 
collection [pull_replica_test_create_delete] has occurred - updating... (live 
nodes size: [2])
  2> 1470503 INFO  (zkCallback-12639-thread-3) [n: c: s: r: x: t:] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_create_delete/state.json zxid: 3365] for 
collection [pull_replica_test_create_delete] has occurred - updating... (live 
nodes size: [2])
  2> 1470503 INFO  (qtp68128679-20785-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node13 
x:pull_replica_test_create_delete_shard2_replica_p5 t:null-22464] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
  2> 1470503 INFO  (qtp68128679-20785-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node13 
x:pull_replica_test_create_delete_shard2_replica_p5 t:null-22464] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
  2> 1470503 INFO  (zkCallback-12785-thread-4) [n: c: s: r: x: t:] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_create_delete/state.json zxid: 3365] for 
collection [pull_replica_test_create_delete] has occurred - updating... (live 
nodes size: [2])
  2> 1470503 INFO  (qtp68128679-20785-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node13 
x:pull_replica_test_create_delete_shard2_replica_p5 t:null-22464] 
o.a.s.c.ZkController pull_replica_test_create_delete_shard2_replica_p5 starting 
background replication from leader
  2> 1470503 INFO  (qtp68128679-20785-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node13 
x:pull_replica_test_create_delete_shard2_replica_p5 t:null-22464] 
o.a.s.c.ReplicateFromLeader Will start replication from leader with poll 
interval: 00:00:01
  2> 1470503 DEBUG (indexFetcher-15307-thread-1) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node14 
x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.h.ReplicationHandler Polling for index modifications
  2> 1470504 INFO  (indexFetcher-15283-thread-1) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node12 
x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.h.IndexFetcher Updated leaderUrl to 
https://127.0.0.1:38867/solr/pull_replica_test_create_delete_shard1_replica_n7/
  2> 1470504 INFO  (indexFetcher-15307-thread-1) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node14 
x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.h.IndexFetcher Updated leaderUrl to 
https://127.0.0.1:38867/solr/pull_replica_test_create_delete_shard1_replica_n7/
  2> 1470504 INFO  (qtp68128679-20785-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node13 
x:pull_replica_test_create_delete_shard2_replica_p5 t:null-22464] 
o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
  2> 1470504 INFO  (qtp68128679-20785-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node13 
x:pull_replica_test_create_delete_shard2_replica_p5 t:null-22464] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
  2> 1470504 INFO  (qtp68128679-20785-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node13 
x:pull_replica_test_create_delete_shard2_replica_p5 t:null-22464] 
o.a.s.c.ZkController No registered searcher found for core: 
pull_replica_test_create_delete_shard2_replica_p5, waiting until a searcher is 
registered before publishing as active
  2> 1470504 INFO  
(searcherExecutor-15270-thread-1-processing-pull_replica_test_create_delete_shard2_replica_p5
 null-22464 core_node13 127.0.0.1:44527_solr pull_replica_test_create_delete 
shard2) [n:127.0.0.1:44527_solr c:pull_replica_test_create_delete s:shard2 
r:core_node13 x:pull_replica_test_create_delete_shard2_replica_p5 t:null-22464] 
o.a.s.c.SolrCore Registered new searcher autowarm time: 0 ms
  2> 1470504 INFO  (qtp1321512416-20584-null-22466) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22466] 
o.a.s.c.S.Request webapp=/solr path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
  2> 1470504 INFO  (qtp1321512416-20584-null-22467) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node15 
x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22467] 
o.a.s.c.S.Request webapp=/solr path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
  2> 1470505 INFO  (qtp68128679-20785-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node13 
x:pull_replica_test_create_delete_shard2_replica_p5 t:null-22464] 
o.a.s.c.ZkController Found a registered searcher: 
Searcher@6f7bc44e[pull_replica_test_create_delete_shard2_replica_p5] 
main{UninvertingDirectoryReader()}, took: 0.0 ms for core: 
pull_replica_test_create_delete_shard2_replica_p5, id: 
org.apache.solr.core.SolrCore@2f90d044 
pull_replica_test_create_delete_shard2_replica_p5
  2> 1470505 INFO  (indexFetcher-15283-thread-1) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node12 
x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.h.IndexFetcher Leader's generation: 1
  2> 1470505 INFO  (indexFetcher-15283-thread-1) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node12 
x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.h.IndexFetcher Leader's version: 0
  2> 1470505 INFO  (indexFetcher-15283-thread-1) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node12 
x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.h.IndexFetcher Follower's generation: 1
  2> 1470505 INFO  (indexFetcher-15283-thread-1) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node12 
x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.h.IndexFetcher Follower's version: 0
  2> 1470505 DEBUG (indexFetcher-15283-thread-1) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node12 
x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22464] 
o.a.s.h.IndexFetcher Nothing to replicate, leader's version is 0
  2> 1470506 INFO  (indexFetcher-15307-thread-1) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node14 
x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.h.IndexFetcher Leader's generation: 1
  2> 1470506 INFO  (indexFetcher-15307-thread-1) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node14 
x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.h.IndexFetcher Leader's version: 0
  2> 1470506 INFO  (indexFetcher-15307-thread-1) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node14 
x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.h.IndexFetcher Follower's generation: 1
  2> 1470506 INFO  (indexFetcher-15307-thread-1) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node14 
x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.h.IndexFetcher Follower's version: 0
  2> 1470506 DEBUG (indexFetcher-15307-thread-1) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s:shard1 r:core_node14 
x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22464] 
o.a.s.h.IndexFetcher Nothing to replicate, leader's version is 0
  2> 1470506 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node9 
x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
  2> 1470506 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node9 
x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
  2> 1470506 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node9 
x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.c.SyncStrategy Sync replicas to 
https://127.0.0.1:38867/solr/pull_replica_test_create_delete_shard2_replica_n1/
  2> 1470506 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node9 
x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
  2> 1470506 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node9 
x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.c.SyncStrategy 
https://127.0.0.1:38867/solr/pull_replica_test_create_delete_shard2_replica_n1/ 
has no replicas
  2> 1470506 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node9 
x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/pull_replica_test_create_delete/leaders/shard2/leader after 
winning as 
/collections/pull_replica_test_create_delete/leader_elect/shard2/election/72097308771876869-core_node9-n_0000000000
  2> 1470697 INFO  (qtp68128679-20788-null-22464) [n:127.0.0.1:44527_solr c: s: 
r: x: t:null-22464] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node12&collection.configName=conf&newCollection=true&name=pull_replica_test_create_delete_shard1_replica_p4&action=CREATE&numShards=2&collection=pull_replica_test_create_delete&shard=shard1&wt=javabin&version=2&replicaType=PULL}
 status=0 QTime=324
  2> 1470698 INFO  (zkCallback-12639-thread-3) [n: c: s: r: x: t:] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_create_delete/state.json zxid: 3367] for 
collection [pull_replica_test_create_delete] has occurred - updating... (live 
nodes size: [2])
  2> 1470698 INFO  (zkCallback-12785-thread-5) [n: c: s: r: x: t:] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_create_delete/state.json zxid: 3367] for 
collection [pull_replica_test_create_delete] has occurred - updating... (live 
nodes size: [2])
  2> 1470699 INFO  (zkCallback-12785-thread-2) [n: c: s: r: x: t:] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_create_delete/state.json zxid: 3369] for 
collection [pull_replica_test_create_delete] has occurred - updating... (live 
nodes size: [2])
  2> 1470699 INFO  (zkCallback-12639-thread-3) [n: c: s: r: x: t:] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_create_delete/state.json zxid: 3369] for 
collection [pull_replica_test_create_delete] has occurred - updating... (live 
nodes size: [2])
  2> 1470699 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node9 
x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:38867/solr/pull_replica_test_create_delete_shard2_replica_n1/ 
shard2
  2> 1470700 INFO  (qtp68128679-20787-null-22464) [n:127.0.0.1:44527_solr c: s: 
r: x: t:null-22464] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node14&collection.configName=conf&newCollection=true&name=pull_replica_test_create_delete_shard1_replica_p6&action=CREATE&numShards=2&collection=pull_replica_test_create_delete&shard=shard1&wt=javabin&version=2&replicaType=PULL}
 status=0 QTime=327
  2> 1470700 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node9 
x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22464] 
o.a.s.c.ZkController I am the leader, no recovery necessary
  2> 1470701 INFO  (zkCallback-12785-thread-5) [n: c: s: r: x: t:] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_create_delete/state.json zxid: 3370] for 
collection [pull_replica_test_create_delete] has occurred - updating... (live 
nodes size: [2])
  2> 1470702 INFO  (zkCallback-12639-thread-3) [n: c: s: r: x: t:] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_create_delete/state.json zxid: 3370] for 
collection [pull_replica_test_create_delete] has occurred - updating... (live 
nodes size: [2])
  2> 1470703 INFO  (qtp1321512416-20588-null-22464) [n:127.0.0.1:38867_solr c: 
s: r: x: t:null-22464] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node9&collection.configName=conf&newCollection=true&name=pull_replica_test_create_delete_shard2_replica_n1&action=CREATE&numShards=2&collection=pull_replica_test_create_delete&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=332
  2> 1470703 INFO  (qtp68128679-20785-null-22464) [n:127.0.0.1:44527_solr c: s: 
r: x: t:null-22464] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node13&collection.configName=conf&newCollection=true&name=pull_replica_test_create_delete_shard2_replica_p5&action=CREATE&numShards=2&collection=pull_replica_test_create_delete&shard=shard2&wt=javabin&version=2&replicaType=PULL}
 status=0 QTime=331
  2> 1470707 INFO  (indexFetcher-15303-thread-1) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s:shard2 r:core_node11 
x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22464] 
o.a.s.h.IndexFetcher Replica core_node9 is leader but it's state is down, 
skipping replication
  2> 1470708 INFO  (qtp1321512416-20890-null-22464) [n:127.0.0.1:38867_solr c: 
s: r: x: t:null-22464] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node10&collection.configName=conf&newCollection=true&name=pull_replica_test_create_delete_shard1_replica_p2&action=CREATE&numShards=2&collection=pull_replica_test_create_delete&shard=shard1&wt=javabin&version=2&replicaType=PULL}
 status=0 QTime=336
  2> 1470708 INFO  (qtp68128679-20789-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s: r: x: t:null-22464] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
45 seconds. Check all shard replicas
  2> 1470708 INFO  (qtp68128679-20789-null-22464) [n:127.0.0.1:44527_solr 
c:pull_replica_test_create_delete s: r: x: t:null-22464] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/collections 
params={pullReplicas=3&collection.configName=conf&name=pull_replica_test_create_delete&nrtReplicas=1&action=CREATE&numShards=2}
 status=0 QTime=364
  2> 1470710 INFO  (qtp1321512416-20585-null-22468) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s: r: x: t:null-22468] 
o.a.s.c.a.c.DistributedCollectionConfigSetCommandRunner Running Collection API 
locally for RELOAD asyncId=null
  2> 1470711 INFO  
(DistributedCollectionApiCommandExecutor-12660-thread-5-processing-127.0.0.1:38867_solr
 null-22468 pull_replica_test_create_delete) [n:127.0.0.1:38867_solr 
c:pull_replica_test_create_delete s: r: x: t:null-22468] 
o.a.s.c.a.c.CollectionHandlingUtils Executing Collection Cmd=action=RELOAD, 
asyncId=null
  2> 1470726 INFO  (qtp1321512416-20583-null-22468) [n:127.0.0.1:38867_solr c: 
s: r: x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22468] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.11.1
  2> 1470726 INFO  (qtp68128679-20788-null-22468) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard2_replica_p5 t:null-22468] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.11.1
  2> 1470727 INFO  (qtp1321512416-20584-null-22468) [n:127.0.0.1:38867_solr c: 
s: r: x:pull_replica_test_create_delete_shard2_replica_n1 t:null-22468] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.11.1
  2> 1470728 INFO  (qtp68128679-20786-null-22468) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard1_replica_p6 t:null-22468] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.11.1
  2> 1470728 INFO  (qtp1321512416-20587-null-22468) [n:127.0.0.1:38867_solr c: 
s: r: x:pull_replica_test_create_delete_shard1_replica_n7 t:null-22468] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.11.1
  2> 1470729 INFO  (qtp68128679-20784-null-22468) [n:127.0.0.1:44527_solr c: s: 
r: x:pull_replica_test_create_delete_shard1_replica_p4 t:null-22468] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.11.1
  2> 1470730 INFO  (qtp1321512416-20583-null-22468) [n:127.0.0.1:38867_solr c: 
s: r: x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22468] 
o.a.s.s.IndexSchema Schema name=minimal
  2> 1470731 INFO  (qtp1321512416-20583-null-22468) [n:127.0.0.1:38867_solr c: 
s: r: x:pull_replica_test_create_delete_shard2_replica_p3 t:null-22468] 
o.a.s.s.IndexSchema Loaded schema minimal/1.7 wi

[...truncated too long message...]

sProvidersTest, ZkControllerTest, ZkFailoverTest, ZkShardTermsTest, 
AsyncCallRequestStatusResponseTest, CollectionApiLockingTest, 
CollectionTooManyReplicasTest, CollectionsAPIDistributedZkTest, 
CustomCollectionTest]

WARNING: Test org.apache.solr.schema.DocValuesTest wrote 11,135,436 bytes of 
output.
WARNING: Test org.apache.solr.schema.TestCloudSchemaless wrote 14,461,192 bytes 
of output.
WARNING: Test org.apache.solr.search.facet.TestCloudJSONFacetSKGEquiv wrote 
14,613,397 bytes of output.

> Task :solr:cross-dc-manager:test
:solr:cross-dc-manager:test (SUCCESS): 37 test(s), 7 skipped

> Task :solr:cross-dc-manager:wipeTaskTemp

> Task :solr:prometheus-exporter:compileJava
Note: Some input files use or override a deprecated API.
Note: Recompile with -Xlint:deprecation for details.

> Task :solr:prometheus-exporter:classes

> Task :solr:prometheus-exporter:compileTestJava
Note: Some input files use or override a deprecated API.
Note: Recompile with -Xlint:deprecation for details.

> Task :solr:prometheus-exporter:testClasses
> Task :solr:prometheus-exporter:test
:solr:prometheus-exporter:test (SUCCESS): 23 test(s)

> Task :solr:prometheus-exporter:wipeTaskTemp

> Task :solr:solr-ref-guide:compileTestJava
Note: Some input files use or override a deprecated API.
Note: Recompile with -Xlint:deprecation for details.

> Task :solr:solr-ref-guide:testClasses
> Task :solr:solr-ref-guide:test
:solr:solr-ref-guide:test (SUCCESS): 32 test(s)

> Task :solr:solr-ref-guide:wipeTaskTemp

> Task :solr:solrj:compileTestJava
Note: Some input files use or override a deprecated API.
Note: Recompile with -Xlint:deprecation for details.

> Task :solr:solrj:processTestResources
> Task :solr:solrj:testClasses
> Task :solr:solrj:test

> Task :solr:core:test
:solr:core:test (FAILURE): 5192 test(s), 6 failure(s), 204 skipped

5192 tests completed, 6 failed, 204 skipped

> Task :solr:core:test FAILED
> Task :solr:core:wipeTaskTemp

> Task :solr:solrj:test
:solr:solrj:test (SUCCESS): 1240 test(s), 40 skipped

> Task :solr:solrj:wipeTaskTemp
ERROR: The following test(s) have failed:
  - org.apache.solr.cloud.ReindexCollectionTest.testReshapeReindexing 
(:solr:core)
    Test history: 
https://ge.apache.org/scans/tests?search.rootProjectNames=solr-root&tests.container=org.apache.solr.cloud.ReindexCollectionTest&tests.test=testReshapeReindexing
 
http://fucit.org/solr-jenkins-reports/history-trend-of-recent-failures.html#series/org.apache.solr.cloud.ReindexCollectionTest.testReshapeReindexing
    Test output: 
/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.cloud.ReindexCollectionTest.txt
    Reproduce with: ./gradlew :solr:core:test --tests 
"org.apache.solr.cloud.ReindexCollectionTest.testReshapeReindexing" 
-Ptests.jvms=2 "-Ptests.jvmargs=-XX:TieredStopAtLevel=1 -XX:+UseParallelGC 
-XX:ActiveProcessorCount=1 -XX:ReservedCodeCacheSize=120m" 
-Ptests.seed=BEBFAFD58271AED0 -Ptests.badapples=false 
-Ptests.file.encoding=US-ASCII

  - org.apache.solr.cloud.TestAuthenticationFramework.testBasics (:solr:core)
    Test history: 
https://ge.apache.org/scans/tests?search.rootProjectNames=solr-root&tests.container=org.apache.solr.cloud.TestAuthenticationFramework&tests.test=testBasics
 
http://fucit.org/solr-jenkins-reports/history-trend-of-recent-failures.html#series/org.apache.solr.cloud.TestAuthenticationFramework.testBasics
    Test output: 
/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.cloud.TestAuthenticationFramework.txt
    Reproduce with: ./gradlew :solr:core:test --tests 
"org.apache.solr.cloud.TestAuthenticationFramework.testBasics" -Ptests.jvms=2 
"-Ptests.jvmargs=-XX:TieredStopAtLevel=1 -XX:+UseParallelGC 
-XX:ActiveProcessorCount=1 -XX:ReservedCodeCacheSize=120m" 
-Ptests.seed=BEBFAFD58271AED0 -Ptests.badapples=false 
-Ptests.file.encoding=US-ASCII

  - org.apache.solr.cloud.SystemCollectionCompatTest.testBackCompat (:solr:core)
    Test history: 
https://ge.apache.org/scans/tests?search.rootProjectNames=solr-root&tests.container=org.apache.solr.cloud.SystemCollectionCompatTest&tests.test=testBackCompat
 
http://fucit.org/solr-jenkins-reports/history-trend-of-recent-failures.html#series/org.apache.solr.cloud.SystemCollectionCompatTest.testBackCompat
    Test output: 
/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.cloud.SystemCollectionCompatTest.txt
    Reproduce with: ./gradlew :solr:core:test --tests 
"org.apache.solr.cloud.SystemCollectionCompatTest.testBackCompat" 
-Ptests.jvms=2 "-Ptests.jvmargs=-XX:TieredStopAtLevel=1 -XX:+UseParallelGC 
-XX:ActiveProcessorCount=1 -XX:ReservedCodeCacheSize=120m" 
-Ptests.seed=BEBFAFD58271AED0 -Ptests.badapples=false 
-Ptests.file.encoding=US-ASCII

  - org.apache.solr.cloud.TestConfigSetsAPI.testNewSingleFileAfterSchemaAPIV1 
(:solr:core)
    Test history: 
https://ge.apache.org/scans/tests?search.rootProjectNames=solr-root&tests.container=org.apache.solr.cloud.TestConfigSetsAPI&tests.test=testNewSingleFileAfterSchemaAPIV1
 
http://fucit.org/solr-jenkins-reports/history-trend-of-recent-failures.html#series/org.apache.solr.cloud.TestConfigSetsAPI.testNewSingleFileAfterSchemaAPIV1
    Test output: 
/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.cloud.TestConfigSetsAPI.txt
    Reproduce with: ./gradlew :solr:core:test --tests 
"org.apache.solr.cloud.TestConfigSetsAPI.testNewSingleFileAfterSchemaAPIV1" 
-Ptests.jvms=2 "-Ptests.jvmargs=-XX:TieredStopAtLevel=1 -XX:+UseParallelGC 
-XX:ActiveProcessorCount=1 -XX:ReservedCodeCacheSize=120m" 
-Ptests.seed=BEBFAFD58271AED0 -Ptests.badapples=false 
-Ptests.file.encoding=US-ASCII

  - org.apache.solr.cloud.TestPullReplica.testCreateDelete 
{seed=[BEBFAFD58271AED0:BCE2E754EECCEA7F]} (:solr:core)
    Test history: 
https://ge.apache.org/scans/tests?search.rootProjectNames=solr-root&tests.container=org.apache.solr.cloud.TestPullReplica&tests.test=testCreateDelete
 {seed=[BEBFAFD58271AED0:BCE2E754EECCEA7F]} 
http://fucit.org/solr-jenkins-reports/history-trend-of-recent-failures.html#series/org.apache.solr.cloud.TestPullReplica.testCreateDelete
 {seed=[BEBFAFD58271AED0:BCE2E754EECCEA7F]}
    Test output: 
/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.cloud.TestPullReplica.txt
    Reproduce with: ./gradlew :solr:core:test --tests 
"org.apache.solr.cloud.TestPullReplica.testCreateDelete 
{seed=[BEBFAFD58271AED0:BCE2E754EECCEA7F]}" -Ptests.jvms=2 
"-Ptests.jvmargs=-XX:TieredStopAtLevel=1 -XX:+UseParallelGC 
-XX:ActiveProcessorCount=1 -XX:ReservedCodeCacheSize=120m" 
-Ptests.seed=BEBFAFD58271AED0 -Ptests.badapples=false 
-Ptests.file.encoding=US-ASCII

  - 
org.apache.solr.cloud.api.collections.CustomCollectionTest.testCustomCollectionsAPI
 (:solr:core)
    Test history: 
https://ge.apache.org/scans/tests?search.rootProjectNames=solr-root&tests.container=org.apache.solr.cloud.api.collections.CustomCollectionTest&tests.test=testCustomCollectionsAPI
 
http://fucit.org/solr-jenkins-reports/history-trend-of-recent-failures.html#series/org.apache.solr.cloud.api.collections.CustomCollectionTest.testCustomCollectionsAPI
    Test output: 
/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.cloud.api.collections.CustomCollectionTest.txt
    Reproduce with: ./gradlew :solr:core:test --tests 
"org.apache.solr.cloud.api.collections.CustomCollectionTest.testCustomCollectionsAPI"
 -Ptests.jvms=2 "-Ptests.jvmargs=-XX:TieredStopAtLevel=1 -XX:+UseParallelGC 
-XX:ActiveProcessorCount=1 -XX:ReservedCodeCacheSize=120m" 
-Ptests.seed=BEBFAFD58271AED0 -Ptests.badapples=false 
-Ptests.file.encoding=US-ASCII


FAILURE: Build failed with an exception.

* What went wrong:
Execution failed for task ':solr:core:test'.
> There were failing tests. See the results at: 
> file:///home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/solr/core/build/test-results/test/

BUILD FAILED in 1h 32m 19s
90 actionable tasks: 72 executed, 18 up-to-date


Traceback (most recent call last):
  File "dev-tools/scripts/smokeTestRelease.py", line 1198, in <module>
    main()
  File "dev-tools/scripts/smokeTestRelease.py", line 1125, in main
    downloadOnly=c.download_only)
  File "dev-tools/scripts/smokeTestRelease.py", line 1186, in smokeTest
    unpackAndVerify(java, tmpDir, 'solr-%s-src.tgz' % version, gitRevision, 
version, testArgs)
  File "dev-tools/scripts/smokeTestRelease.py", line 575, in unpackAndVerify
    verifyUnpacked(java, artifact, unpackPath, gitRevision, version, testArgs)
  File "dev-tools/scripts/smokeTestRelease.py", line 666, in verifyUnpacked
    java.run_java11('./gradlew --no-daemon test %s' % testArgs, '%s/test.log' % 
unpackPath)
  File "dev-tools/scripts/smokeTestRelease.py", line 1034, in run_java
    run('%s; %s' % (cmd_prefix, cmd), logfile)
  File "dev-tools/scripts/smokeTestRelease.py", line 505, in run
    raise RuntimeError('command "%s" failed; see log file %s' % (command, 
logPath))
RuntimeError: command "export JAVA_HOME="/home/jenkins/tools/java/latest11" 
PATH="/home/jenkins/tools/java/latest11/bin:$PATH" 
JAVACMD="/home/jenkins/tools/java/latest11/bin/java"; ./gradlew --no-daemon 
test -Dtests.nightly=false -Dtests.badapples=false " failed; see log file 
/home/jenkins/jenkins-slave/workspace/Solr/Solr-Smoketest-9.8/_tmp/smoke_1743694306/unpack/solr-9.8.2/test.log
Build step 'Run with timeout' marked build as failure
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to