Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/984/
2 tests failed.
FAILED: org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest.testMaxOps
Error Message:
events: [CapturedEvent{timestamp=8087061198114639, stage=STARTED,
actionName='null', event={ "id":"1cbb21e64eff7bT9fgo8fsje46ukzid6l33ma7io",
"source":"index_size_trigger5", "eventTime":8087053620150139,
"eventType":"INDEXSIZE", "properties":{ "__start__":5,
"__compute_diag__":{ "estimatedMaxOps":30, "requestedOperations":5,
"opLimit":5, "opLimitReached":true, "maxOperations":30},
"aboveSize":{ "testMaxOps_collection_shard1_replica_n1":"docs=38,
bytes=88064", "testMaxOps_collection_shard2_replica_n3":"docs=38,
bytes=88064", "testMaxOps_collection_shard3_replica_n5":"docs=30,
bytes=71680", "testMaxOps_collection_shard4_replica_n7":"docs=46,
bytes=104448", "testMaxOps_collection_shard5_replica_n9":"docs=48,
bytes=108544"}, "belowSize":{}, "_enqueue_time_":8087061163329239,
"requestedOps":[ { "action":"SPLITSHARD", "hints":{
"COLL_SHARD":[{ "first":"testMaxOps_collection",
"second":"shard5"}], "PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}, { "action":"SPLITSHARD",
"hints":{ "COLL_SHARD":[{
"first":"testMaxOps_collection", "second":"shard4"}],
"PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}, { "action":"SPLITSHARD",
"hints":{ "COLL_SHARD":[{
"first":"testMaxOps_collection", "second":"shard2"}],
"PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}, { "action":"SPLITSHARD",
"hints":{ "COLL_SHARD":[{
"first":"testMaxOps_collection", "second":"shard1"}],
"PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}, { "action":"SPLITSHARD",
"hints":{ "COLL_SHARD":[{
"first":"testMaxOps_collection", "second":"shard3"}],
"PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}]}}, context={}, config={
"trigger":"index_size_trigger5", "stage":[ "STARTED", "ABORTED",
"SUCCEEDED", "FAILED"], "beforeAction":["compute_plan"],
"afterAction":["compute_plan"],
"class":"org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest$CapturingTriggerListener"},
message='null'}, CapturedEvent{timestamp=8087061274700939,
stage=BEFORE_ACTION, actionName='compute_plan', event={
"id":"1cbb21e64eff7bT9fgo8fsje46ukzid6l33ma7io",
"source":"index_size_trigger5", "eventTime":8087053620150139,
"eventType":"INDEXSIZE", "properties":{ "__start__":5,
"__compute_diag__":{ "estimatedMaxOps":30, "requestedOperations":5,
"opLimit":5, "opLimitReached":true, "maxOperations":30},
"aboveSize":{ "testMaxOps_collection_shard1_replica_n1":"docs=38,
bytes=88064", "testMaxOps_collection_shard2_replica_n3":"docs=38,
bytes=88064", "testMaxOps_collection_shard3_replica_n5":"docs=30,
bytes=71680", "testMaxOps_collection_shard4_replica_n7":"docs=46,
bytes=104448", "testMaxOps_collection_shard5_replica_n9":"docs=48,
bytes=108544"}, "belowSize":{}, "_enqueue_time_":8087061163329239,
"requestedOps":[ { "action":"SPLITSHARD", "hints":{
"COLL_SHARD":[{ "first":"testMaxOps_collection",
"second":"shard5"}], "PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}, { "action":"SPLITSHARD",
"hints":{ "COLL_SHARD":[{
"first":"testMaxOps_collection", "second":"shard4"}],
"PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}, { "action":"SPLITSHARD",
"hints":{ "COLL_SHARD":[{
"first":"testMaxOps_collection", "second":"shard2"}],
"PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}, { "action":"SPLITSHARD",
"hints":{ "COLL_SHARD":[{
"first":"testMaxOps_collection", "second":"shard1"}],
"PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}, { "action":"SPLITSHARD",
"hints":{ "COLL_SHARD":[{
"first":"testMaxOps_collection", "second":"shard3"}],
"PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}]}}, context={properties.BEFORE_ACTION=[compute_plan],
source=index_size_trigger5}, config={ "trigger":"index_size_trigger5",
"stage":[ "STARTED", "ABORTED", "SUCCEEDED", "FAILED"],
"beforeAction":["compute_plan"], "afterAction":["compute_plan"],
"class":"org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest$CapturingTriggerListener"},
message='null'}, CapturedEvent{timestamp=8087061448724089, stage=AFTER_ACTION,
actionName='compute_plan', event={
"id":"1cbb21e64eff7bT9fgo8fsje46ukzid6l33ma7io",
"source":"index_size_trigger5", "eventTime":8087053620150139,
"eventType":"INDEXSIZE", "properties":{ "__start__":5,
"__compute_diag__":{ "estimatedMaxOps":30, "requestedOperations":5,
"opLimit":5, "opLimitReached":true, "maxOperations":30},
"aboveSize":{ "testMaxOps_collection_shard1_replica_n1":"docs=38,
bytes=88064", "testMaxOps_collection_shard2_replica_n3":"docs=38,
bytes=88064", "testMaxOps_collection_shard3_replica_n5":"docs=30,
bytes=71680", "testMaxOps_collection_shard4_replica_n7":"docs=46,
bytes=104448", "testMaxOps_collection_shard5_replica_n9":"docs=48,
bytes=108544"}, "belowSize":{}, "_enqueue_time_":8087061163329239,
"requestedOps":[ { "action":"SPLITSHARD", "hints":{
"COLL_SHARD":[{ "first":"testMaxOps_collection",
"second":"shard5"}], "PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}, { "action":"SPLITSHARD",
"hints":{ "COLL_SHARD":[{
"first":"testMaxOps_collection", "second":"shard4"}],
"PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}, { "action":"SPLITSHARD",
"hints":{ "COLL_SHARD":[{
"first":"testMaxOps_collection", "second":"shard2"}],
"PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}, { "action":"SPLITSHARD",
"hints":{ "COLL_SHARD":[{
"first":"testMaxOps_collection", "second":"shard1"}],
"PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}, { "action":"SPLITSHARD",
"hints":{ "COLL_SHARD":[{
"first":"testMaxOps_collection", "second":"shard3"}],
"PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}]}}, context={properties.operations=[{
"class":"org.apache.solr.client.solrj.request.CollectionAdminRequest$SplitShard",
"method":"GET", "params.action":"SPLITSHARD",
"params.collection":"testMaxOps_collection", "params.shard":"shard5",
"params.splitMethod":"link", "params.splitByPrefix":"false"}, {
"class":"org.apache.solr.client.solrj.request.CollectionAdminRequest$SplitShard",
"method":"GET", "params.action":"SPLITSHARD",
"params.collection":"testMaxOps_collection", "params.shard":"shard4",
"params.splitMethod":"link", "params.splitByPrefix":"false"}, {
"class":"org.apache.solr.client.solrj.request.CollectionAdminRequest$SplitShard",
"method":"GET", "params.action":"SPLITSHARD",
"params.collection":"testMaxOps_collection", "params.shard":"shard2",
"params.splitMethod":"link", "params.splitByPrefix":"false"}, {
"class":"org.apache.solr.client.solrj.request.CollectionAdminRequest$SplitShard",
"method":"GET", "params.action":"SPLITSHARD",
"params.collection":"testMaxOps_collection", "params.shard":"shard1",
"params.splitMethod":"link", "params.splitByPrefix":"false"}, {
"class":"org.apache.solr.client.solrj.request.CollectionAdminRequest$SplitShard",
"method":"GET", "params.action":"SPLITSHARD",
"params.collection":"testMaxOps_collection", "params.shard":"shard3",
"params.splitMethod":"link", "params.splitByPrefix":"false"}],
properties.BEFORE_ACTION=[compute_plan], source=index_size_trigger5,
properties.AFTER_ACTION=[compute_plan]}, config={
"trigger":"index_size_trigger5", "stage":[ "STARTED", "ABORTED",
"SUCCEEDED", "FAILED"], "beforeAction":["compute_plan"],
"afterAction":["compute_plan"],
"class":"org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest$CapturingTriggerListener"},
message='null'}, CapturedEvent{timestamp=8087061504141189, stage=SUCCEEDED,
actionName='null', event={ "id":"1cbb21e64eff7bT9fgo8fsje46ukzid6l33ma7io",
"source":"index_size_trigger5", "eventTime":8087053620150139,
"eventType":"INDEXSIZE", "properties":{ "__start__":5,
"__compute_diag__":{ "estimatedMaxOps":30, "requestedOperations":5,
"opLimit":5, "opLimitReached":true, "maxOperations":30},
"aboveSize":{ "testMaxOps_collection_shard1_replica_n1":"docs=38,
bytes=88064", "testMaxOps_collection_shard2_replica_n3":"docs=38,
bytes=88064", "testMaxOps_collection_shard3_replica_n5":"docs=30,
bytes=71680", "testMaxOps_collection_shard4_replica_n7":"docs=46,
bytes=104448", "testMaxOps_collection_shard5_replica_n9":"docs=48,
bytes=108544"}, "belowSize":{}, "_enqueue_time_":8087061163329239,
"requestedOps":[ { "action":"SPLITSHARD", "hints":{
"COLL_SHARD":[{ "first":"testMaxOps_collection",
"second":"shard5"}], "PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}, { "action":"SPLITSHARD",
"hints":{ "COLL_SHARD":[{
"first":"testMaxOps_collection", "second":"shard4"}],
"PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}, { "action":"SPLITSHARD",
"hints":{ "COLL_SHARD":[{
"first":"testMaxOps_collection", "second":"shard2"}],
"PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}, { "action":"SPLITSHARD",
"hints":{ "COLL_SHARD":[{
"first":"testMaxOps_collection", "second":"shard1"}],
"PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}, { "action":"SPLITSHARD",
"hints":{ "COLL_SHARD":[{
"first":"testMaxOps_collection", "second":"shard3"}],
"PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}]}}, context={}, config={
"trigger":"index_size_trigger5", "stage":[ "STARTED", "ABORTED",
"SUCCEEDED", "FAILED"], "beforeAction":["compute_plan"],
"afterAction":["compute_plan"],
"class":"org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest$CapturingTriggerListener"},
message='null'}, CapturedEvent{timestamp=8087068768159589, stage=STARTED,
actionName='null', event={ "id":"1cbb239cf1b335T9fgo8fsje46ukzid6l33ma7ip",
"source":"index_size_trigger5", "eventTime":8087060979233589,
"eventType":"INDEXSIZE", "properties":{ "aboveSize":{
"testMaxOps_collection_shard1_replica_n1":"docs=38, bytes=88064",
"testMaxOps_collection_shard2_replica_n3":"docs=38, bytes=88064",
"testMaxOps_collection_shard3_replica_n5":"docs=30, bytes=71680",
"testMaxOps_collection_shard4_replica_n7":"docs=46, bytes=104448",
"testMaxOps_collection_shard5_replica_n9":"docs=48, bytes=108544"},
"belowSize":{}, "_enqueue_time_":8087068702921739, "requestedOps":[
{ "action":"SPLITSHARD", "hints":{ "COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard5"}], "PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}, { "action":"SPLITSHARD",
"hints":{ "COLL_SHARD":[{
"first":"testMaxOps_collection", "second":"shard4"}],
"PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}, { "action":"SPLITSHARD",
"hints":{ "COLL_SHARD":[{
"first":"testMaxOps_collection", "second":"shard2"}],
"PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}, { "action":"SPLITSHARD",
"hints":{ "COLL_SHARD":[{
"first":"testMaxOps_collection", "second":"shard1"}],
"PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}, { "action":"SPLITSHARD",
"hints":{ "COLL_SHARD":[{
"first":"testMaxOps_collection", "second":"shard3"}],
"PARAMS":{ "splitByPrefix":false,
"splitMethod":"link"}}}]}}, context={}, config={
"trigger":"index_size_trigger5", "stage":[ "STARTED", "ABORTED",
"SUCCEEDED", "FAILED"], "beforeAction":["compute_plan"],
"afterAction":["compute_plan"],
"class":"org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest$CapturingTriggerListener"},
message='null'}] expected:<4> but was:<5>
Stack Trace:
java.lang.AssertionError: events: [CapturedEvent{timestamp=8087061198114639,
stage=STARTED, actionName='null', event={
"id":"1cbb21e64eff7bT9fgo8fsje46ukzid6l33ma7io",
"source":"index_size_trigger5",
"eventTime":8087053620150139,
"eventType":"INDEXSIZE",
"properties":{
"__start__":5,
"__compute_diag__":{
"estimatedMaxOps":30,
"requestedOperations":5,
"opLimit":5,
"opLimitReached":true,
"maxOperations":30},
"aboveSize":{
"testMaxOps_collection_shard1_replica_n1":"docs=38, bytes=88064",
"testMaxOps_collection_shard2_replica_n3":"docs=38, bytes=88064",
"testMaxOps_collection_shard3_replica_n5":"docs=30, bytes=71680",
"testMaxOps_collection_shard4_replica_n7":"docs=46, bytes=104448",
"testMaxOps_collection_shard5_replica_n9":"docs=48, bytes=108544"},
"belowSize":{},
"_enqueue_time_":8087061163329239,
"requestedOps":[
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard5"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}},
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard4"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}},
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard2"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}},
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard1"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}},
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard3"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}}]}}, context={}, config={
"trigger":"index_size_trigger5",
"stage":[
"STARTED",
"ABORTED",
"SUCCEEDED",
"FAILED"],
"beforeAction":["compute_plan"],
"afterAction":["compute_plan"],
"class":"org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest$CapturingTriggerListener"},
message='null'}, CapturedEvent{timestamp=8087061274700939,
stage=BEFORE_ACTION, actionName='compute_plan', event={
"id":"1cbb21e64eff7bT9fgo8fsje46ukzid6l33ma7io",
"source":"index_size_trigger5",
"eventTime":8087053620150139,
"eventType":"INDEXSIZE",
"properties":{
"__start__":5,
"__compute_diag__":{
"estimatedMaxOps":30,
"requestedOperations":5,
"opLimit":5,
"opLimitReached":true,
"maxOperations":30},
"aboveSize":{
"testMaxOps_collection_shard1_replica_n1":"docs=38, bytes=88064",
"testMaxOps_collection_shard2_replica_n3":"docs=38, bytes=88064",
"testMaxOps_collection_shard3_replica_n5":"docs=30, bytes=71680",
"testMaxOps_collection_shard4_replica_n7":"docs=46, bytes=104448",
"testMaxOps_collection_shard5_replica_n9":"docs=48, bytes=108544"},
"belowSize":{},
"_enqueue_time_":8087061163329239,
"requestedOps":[
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard5"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}},
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard4"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}},
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard2"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}},
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard1"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}},
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard3"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}}]}},
context={properties.BEFORE_ACTION=[compute_plan], source=index_size_trigger5},
config={
"trigger":"index_size_trigger5",
"stage":[
"STARTED",
"ABORTED",
"SUCCEEDED",
"FAILED"],
"beforeAction":["compute_plan"],
"afterAction":["compute_plan"],
"class":"org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest$CapturingTriggerListener"},
message='null'}, CapturedEvent{timestamp=8087061448724089, stage=AFTER_ACTION,
actionName='compute_plan', event={
"id":"1cbb21e64eff7bT9fgo8fsje46ukzid6l33ma7io",
"source":"index_size_trigger5",
"eventTime":8087053620150139,
"eventType":"INDEXSIZE",
"properties":{
"__start__":5,
"__compute_diag__":{
"estimatedMaxOps":30,
"requestedOperations":5,
"opLimit":5,
"opLimitReached":true,
"maxOperations":30},
"aboveSize":{
"testMaxOps_collection_shard1_replica_n1":"docs=38, bytes=88064",
"testMaxOps_collection_shard2_replica_n3":"docs=38, bytes=88064",
"testMaxOps_collection_shard3_replica_n5":"docs=30, bytes=71680",
"testMaxOps_collection_shard4_replica_n7":"docs=46, bytes=104448",
"testMaxOps_collection_shard5_replica_n9":"docs=48, bytes=108544"},
"belowSize":{},
"_enqueue_time_":8087061163329239,
"requestedOps":[
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard5"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}},
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard4"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}},
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard2"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}},
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard1"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}},
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard3"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}}]}}, context={properties.operations=[{
"class":"org.apache.solr.client.solrj.request.CollectionAdminRequest$SplitShard",
"method":"GET",
"params.action":"SPLITSHARD",
"params.collection":"testMaxOps_collection",
"params.shard":"shard5",
"params.splitMethod":"link",
"params.splitByPrefix":"false"}, {
"class":"org.apache.solr.client.solrj.request.CollectionAdminRequest$SplitShard",
"method":"GET",
"params.action":"SPLITSHARD",
"params.collection":"testMaxOps_collection",
"params.shard":"shard4",
"params.splitMethod":"link",
"params.splitByPrefix":"false"}, {
"class":"org.apache.solr.client.solrj.request.CollectionAdminRequest$SplitShard",
"method":"GET",
"params.action":"SPLITSHARD",
"params.collection":"testMaxOps_collection",
"params.shard":"shard2",
"params.splitMethod":"link",
"params.splitByPrefix":"false"}, {
"class":"org.apache.solr.client.solrj.request.CollectionAdminRequest$SplitShard",
"method":"GET",
"params.action":"SPLITSHARD",
"params.collection":"testMaxOps_collection",
"params.shard":"shard1",
"params.splitMethod":"link",
"params.splitByPrefix":"false"}, {
"class":"org.apache.solr.client.solrj.request.CollectionAdminRequest$SplitShard",
"method":"GET",
"params.action":"SPLITSHARD",
"params.collection":"testMaxOps_collection",
"params.shard":"shard3",
"params.splitMethod":"link",
"params.splitByPrefix":"false"}], properties.BEFORE_ACTION=[compute_plan],
source=index_size_trigger5, properties.AFTER_ACTION=[compute_plan]}, config={
"trigger":"index_size_trigger5",
"stage":[
"STARTED",
"ABORTED",
"SUCCEEDED",
"FAILED"],
"beforeAction":["compute_plan"],
"afterAction":["compute_plan"],
"class":"org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest$CapturingTriggerListener"},
message='null'}, CapturedEvent{timestamp=8087061504141189, stage=SUCCEEDED,
actionName='null', event={
"id":"1cbb21e64eff7bT9fgo8fsje46ukzid6l33ma7io",
"source":"index_size_trigger5",
"eventTime":8087053620150139,
"eventType":"INDEXSIZE",
"properties":{
"__start__":5,
"__compute_diag__":{
"estimatedMaxOps":30,
"requestedOperations":5,
"opLimit":5,
"opLimitReached":true,
"maxOperations":30},
"aboveSize":{
"testMaxOps_collection_shard1_replica_n1":"docs=38, bytes=88064",
"testMaxOps_collection_shard2_replica_n3":"docs=38, bytes=88064",
"testMaxOps_collection_shard3_replica_n5":"docs=30, bytes=71680",
"testMaxOps_collection_shard4_replica_n7":"docs=46, bytes=104448",
"testMaxOps_collection_shard5_replica_n9":"docs=48, bytes=108544"},
"belowSize":{},
"_enqueue_time_":8087061163329239,
"requestedOps":[
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard5"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}},
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard4"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}},
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard2"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}},
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard1"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}},
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard3"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}}]}}, context={}, config={
"trigger":"index_size_trigger5",
"stage":[
"STARTED",
"ABORTED",
"SUCCEEDED",
"FAILED"],
"beforeAction":["compute_plan"],
"afterAction":["compute_plan"],
"class":"org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest$CapturingTriggerListener"},
message='null'}, CapturedEvent{timestamp=8087068768159589, stage=STARTED,
actionName='null', event={
"id":"1cbb239cf1b335T9fgo8fsje46ukzid6l33ma7ip",
"source":"index_size_trigger5",
"eventTime":8087060979233589,
"eventType":"INDEXSIZE",
"properties":{
"aboveSize":{
"testMaxOps_collection_shard1_replica_n1":"docs=38, bytes=88064",
"testMaxOps_collection_shard2_replica_n3":"docs=38, bytes=88064",
"testMaxOps_collection_shard3_replica_n5":"docs=30, bytes=71680",
"testMaxOps_collection_shard4_replica_n7":"docs=46, bytes=104448",
"testMaxOps_collection_shard5_replica_n9":"docs=48, bytes=108544"},
"belowSize":{},
"_enqueue_time_":8087068702921739,
"requestedOps":[
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard5"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}},
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard4"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}},
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard2"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}},
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard1"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}},
{
"action":"SPLITSHARD",
"hints":{
"COLL_SHARD":[{
"first":"testMaxOps_collection",
"second":"shard3"}],
"PARAMS":{
"splitByPrefix":false,
"splitMethod":"link"}}}]}}, context={}, config={
"trigger":"index_size_trigger5",
"stage":[
"STARTED",
"ABORTED",
"SUCCEEDED",
"FAILED"],
"beforeAction":["compute_plan"],
"afterAction":["compute_plan"],
"class":"org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest$CapturingTriggerListener"},
message='null'}] expected:<4> but was:<5>
at
__randomizedtesting.SeedInfo.seed([5E0761BC730CB21D:BFF82CD93DA98FE8]:0)
at org.junit.Assert.fail(Assert.java:89)
at org.junit.Assert.failNotEquals(Assert.java:835)
at org.junit.Assert.assertEquals(Assert.java:647)
at
org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest.testMaxOps(IndexSizeTriggerTest.java:595)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED:
org.apache.solr.cloud.TestPullReplicaErrorHandling.testCantConnectToPullReplica
Error Message:
Error from server at http://127.0.0.1:37697/solr: Cannot create collection
pull_replica_error_handling_test_cant_connect_to_pull_replica. Value of
maxShardsPerNode is 1, and the number of nodes currently live or live and part
of your createNodeSet is 3. This allows a maximum of 3 to be created. Value of
numShards is 2, value of nrtReplicas is 1, value of tlogReplicas is 0 and value
of pullReplicas is 1. This requires 4 shards to be created (higher than the
allowed number)
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at http://127.0.0.1:37697/solr: Cannot create collection
pull_replica_error_handling_test_cant_connect_to_pull_replica. Value of
maxShardsPerNode is 1, and the number of nodes currently live or live and part
of your createNodeSet is 3. This allows a maximum of 3 to be created. Value of
numShards is 2, value of nrtReplicas is 1, value of tlogReplicas is 0 and value
of pullReplicas is 1. This requires 4 shards to be created (higher than the
allowed number)
at
__randomizedtesting.SeedInfo.seed([5E0761BC730CB21D:56308774A8A2C693]:0)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:681)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:266)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
at
org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:369)
at
org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:297)
at
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1171)
at
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:934)
at
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:866)
at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:214)
at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:231)
at
org.apache.solr.cloud.TestPullReplicaErrorHandling.testCantConnectToPullReplica(TestPullReplicaErrorHandling.java:149)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 13932 lines...]
[junit4] Suite: org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest
[junit4] 2> 514890 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to
test-framework derived value of
'/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/server/solr/configsets/_default/conf'
[junit4] 2> 514891 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.SolrTestCaseJ4 Created dataDir:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.cloud.autoscaling.IndexSizeTriggerTest_5E0761BC730CB21D-001/data-dir-51-001
[junit4] 2> 514891 WARN
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=607 numCloses=607
[junit4] 2> 514892 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 514893 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 514893 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 514895 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.cloud.autoscaling.IndexSizeTriggerTest_5E0761BC730CB21D-001/tempDir-001
[junit4] 2> 514895 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 514896 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 514896 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 514897 WARN (ZkTestServer Run Thread) [ ]
o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 515168 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port: 36223
[junit4] 2> 515168 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:36223
[junit4] 2> 515168 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:36223
[junit4] 2> 515168 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1 36223
[junit4] 2> 515183 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 515185 INFO (zkConnectionManagerCallback-4386-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 515185 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 515199 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 515200 INFO (zkConnectionManagerCallback-4388-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 515200 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 515201 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 515203 INFO (zkConnectionManagerCallback-4390-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 515203 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 515309 INFO (jetty-launcher-4391-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 515309 INFO (jetty-launcher-4391-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 515309 INFO (jetty-launcher-4391-thread-1) [ ]
o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git:
e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 515310 INFO (jetty-launcher-4391-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 515310 INFO (jetty-launcher-4391-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 515311 INFO (jetty-launcher-4391-thread-2) [ ]
o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git:
e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 515318 INFO (jetty-launcher-4391-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 515318 INFO (jetty-launcher-4391-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 515318 INFO (jetty-launcher-4391-thread-2) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 515324 INFO (jetty-launcher-4391-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@30cd5208{/solr,null,AVAILABLE}
[junit4] 2> 515337 INFO (jetty-launcher-4391-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 515337 INFO (jetty-launcher-4391-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 515337 INFO (jetty-launcher-4391-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 515342 INFO (jetty-launcher-4391-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@15c7d369{/solr,null,AVAILABLE}
[junit4] 2> 515343 INFO (jetty-launcher-4391-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@6423e693{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:39497}
[junit4] 2> 515343 INFO (jetty-launcher-4391-thread-2) [ ]
o.e.j.s.Server Started @515368ms
[junit4] 2> 515343 INFO (jetty-launcher-4391-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
zkHost=127.0.0.1:36223/solr, hostPort=39497}
[junit4] 2> 515343 ERROR (jetty-launcher-4391-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 515343 INFO (jetty-launcher-4391-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 515343 INFO (jetty-launcher-4391-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.8.0
[junit4] 2> 515343 INFO (jetty-launcher-4391-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 515344 INFO (jetty-launcher-4391-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 515344 INFO (jetty-launcher-4391-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-12-03T21:05:04.152Z
[junit4] 2> 515350 INFO (jetty-launcher-4391-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 515362 INFO (jetty-launcher-4391-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@7ad76618{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:36811}
[junit4] 2> 515362 INFO (jetty-launcher-4391-thread-1) [ ]
o.e.j.s.Server Started @515387ms
[junit4] 2> 515362 INFO (jetty-launcher-4391-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
zkHost=127.0.0.1:36223/solr, hostPort=36811}
[junit4] 2> 515362 ERROR (jetty-launcher-4391-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 515362 INFO (jetty-launcher-4391-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 515362 INFO (jetty-launcher-4391-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.8.0
[junit4] 2> 515362 INFO (jetty-launcher-4391-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 515362 INFO (jetty-launcher-4391-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 515363 INFO (jetty-launcher-4391-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-12-03T21:05:04.171Z
[junit4] 2> 515365 INFO (zkConnectionManagerCallback-4393-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 515365 INFO (jetty-launcher-4391-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 515366 INFO (zkConnectionManagerCallback-4395-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 515366 INFO (jetty-launcher-4391-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 515366 INFO (jetty-launcher-4391-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 515367 INFO (jetty-launcher-4391-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 515367 INFO (jetty-launcher-4391-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 515374 WARN
(jetty-launcher-4391-thread-2-SendThread(127.0.0.1:36223)) [ ]
o.a.z.ClientCnxn An exception was thrown while closing send thread for session
0x101e1595c0f0003.
[junit4] 2> => EndOfStreamException: Unable to read additional
data from server sessionid 0x101e1595c0f0003, likely server has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable
to read additional data from server sessionid 0x101e1595c0f0003, likely server
has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350)
~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275)
[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 515374 WARN
(jetty-launcher-4391-thread-1-SendThread(127.0.0.1:36223)) [ ]
o.a.z.ClientCnxn An exception was thrown while closing send thread for session
0x101e1595c0f0004.
[junit4] 2> => EndOfStreamException: Unable to read additional
data from server sessionid 0x101e1595c0f0004, likely server has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable
to read additional data from server sessionid 0x101e1595c0f0004, likely server
has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350)
~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275)
[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 516350 INFO (jetty-launcher-4391-thread-2) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 516351 WARN (jetty-launcher-4391-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@5aa2b44e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 516351 WARN (jetty-launcher-4391-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@5aa2b44e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 516356 WARN (jetty-launcher-4391-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@566002fb[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 516356 WARN (jetty-launcher-4391-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@566002fb[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 516357 INFO (jetty-launcher-4391-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36223/solr
[junit4] 2> 516358 INFO (jetty-launcher-4391-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 516362 INFO (zkConnectionManagerCallback-4409-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 516362 INFO (jetty-launcher-4391-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 516466 INFO (jetty-launcher-4391-thread-2)
[n:127.0.0.1:39497_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 516483 INFO (zkConnectionManagerCallback-4411-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 516483 INFO (jetty-launcher-4391-thread-2)
[n:127.0.0.1:39497_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 516523 INFO (jetty-launcher-4391-thread-1) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 516537 WARN (jetty-launcher-4391-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@461c42af[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 516537 WARN (jetty-launcher-4391-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@461c42af[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 516541 WARN (jetty-launcher-4391-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@40eff64f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 516541 WARN (jetty-launcher-4391-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@40eff64f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 516542 INFO (jetty-launcher-4391-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36223/solr
[junit4] 2> 516544 INFO (jetty-launcher-4391-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 516544 INFO (zkConnectionManagerCallback-4419-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 516545 INFO (jetty-launcher-4391-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 516546 WARN
(jetty-launcher-4391-thread-1-SendThread(127.0.0.1:36223)) [ ]
o.a.z.ClientCnxn An exception was thrown while closing send thread for session
0x101e1595c0f0007.
[junit4] 2> => EndOfStreamException: Unable to read additional
data from server sessionid 0x101e1595c0f0007, likely server has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable
to read additional data from server sessionid 0x101e1595c0f0007, likely server
has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350)
~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275)
[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 516647 INFO (jetty-launcher-4391-thread-1)
[n:127.0.0.1:36811_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 516648 INFO (zkConnectionManagerCallback-4423-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 516648 INFO (jetty-launcher-4391-thread-1)
[n:127.0.0.1:36811_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 516841 INFO (jetty-launcher-4391-thread-1)
[n:127.0.0.1:36811_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:36811_solr
[junit4] 2> 516843 INFO (jetty-launcher-4391-thread-1)
[n:127.0.0.1:36811_solr ] o.a.s.c.Overseer Overseer
(id=72586842927464456-127.0.0.1:36811_solr-n_0000000000) starting
[junit4] 2> 516855 INFO
(OverseerStateUpdate-72586842927464456-127.0.0.1:36811_solr-n_0000000000)
[n:127.0.0.1:36811_solr ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:36811_solr
[junit4] 2> 516861 INFO (jetty-launcher-4391-thread-1)
[n:127.0.0.1:36811_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:36811_solr
[junit4] 2> 516861 DEBUG
(OverseerAutoScalingTriggerThread-72586842927464456-127.0.0.1:36811_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and
.scheduled_maintenance triggers
[junit4] 2> 516870 DEBUG
(OverseerAutoScalingTriggerThread-72586842927464456-127.0.0.1:36811_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with
znode version 1
[junit4] 2> 516870 DEBUG
(OverseerAutoScalingTriggerThread-72586842927464456-127.0.0.1:36811_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1,
lastZnodeVersion 0
[junit4] 2> 516870 DEBUG
(OverseerAutoScalingTriggerThread-72586842927464456-127.0.0.1:36811_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto
znodeVersion 1
[junit4] 2> 516872 INFO (zkCallback-4422-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 516875 INFO (jetty-launcher-4391-thread-1)
[n:127.0.0.1:36811_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 516875 WARN (jetty-launcher-4391-thread-1)
[n:127.0.0.1:36811_solr ] o.a.s.c.CoreContainer Not all security plugins
configured! authentication=disabled authorization=disabled. Solr is only as
secure as you make it. Consider configuring authentication/authorization before
exposing Solr to users internal or external. See
https://s.apache.org/solrsecurity for more info
[junit4] 2> 517100 INFO (jetty-launcher-4391-thread-1)
[n:127.0.0.1:36811_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 517104 DEBUG
(OverseerAutoScalingTriggerThread-72586842927464456-127.0.0.1:36811_solr-n_0000000000)
[ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial
livenodes: [127.0.0.1:36811_solr]
[junit4] 2> 517109 DEBUG
(OverseerAutoScalingTriggerThread-72586842927464456-127.0.0.1:36811_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost /
nodeAdded markers
[junit4] 2> 517118 DEBUG
(OverseerAutoScalingTriggerThread-72586842927464456-127.0.0.1:36811_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1,
lastZnodeVersion 1
[junit4] 2> 517119 DEBUG (ScheduledTrigger-4428-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 1 and last live nodes: 1
[junit4] 2> 517155 INFO (jetty-launcher-4391-thread-1)
[n:127.0.0.1:36811_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36811.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1a34b4cd
[junit4] 2> 517157 INFO (jetty-launcher-4391-thread-2)
[n:127.0.0.1:39497_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 517165 INFO (jetty-launcher-4391-thread-1)
[n:127.0.0.1:36811_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36811.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1a34b4cd
[junit4] 2> 517166 INFO (jetty-launcher-4391-thread-1)
[n:127.0.0.1:36811_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36811.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1a34b4cd
[junit4] 2> 517167 INFO (jetty-launcher-4391-thread-2)
[n:127.0.0.1:39497_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:39497_solr as DOWN
[junit4] 2> 517168 INFO (jetty-launcher-4391-thread-1)
[n:127.0.0.1:36811_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.cloud.autoscaling.IndexSizeTriggerTest_5E0761BC730CB21D-001/tempDir-001/node1
[junit4] 2> 517169 INFO (jetty-launcher-4391-thread-2)
[n:127.0.0.1:39497_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 517169 INFO (jetty-launcher-4391-thread-2)
[n:127.0.0.1:39497_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:39497_solr
[junit4] 2> 517171 INFO (jetty-launcher-4391-thread-2)
[n:127.0.0.1:39497_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 517171 WARN (jetty-launcher-4391-thread-2)
[n:127.0.0.1:39497_solr ] o.a.s.c.CoreContainer Not all security plugins
configured! authentication=disabled authorization=disabled. Solr is only as
secure as you make it. Consider configuring authentication/authorization before
exposing Solr to users internal or external. See
https://s.apache.org/solrsecurity for more info
[junit4] 2> 517178 INFO (zkCallback-4410-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 517178 INFO (zkCallback-4422-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 517215 INFO (jetty-launcher-4391-thread-2)
[n:127.0.0.1:39497_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 517249 INFO (jetty-launcher-4391-thread-2)
[n:127.0.0.1:39497_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39497.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1a34b4cd
[junit4] 2> 517476 INFO (jetty-launcher-4391-thread-2)
[n:127.0.0.1:39497_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39497.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1a34b4cd
[junit4] 2> 517476 INFO (jetty-launcher-4391-thread-2)
[n:127.0.0.1:39497_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39497.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1a34b4cd
[junit4] 2> 517477 INFO (jetty-launcher-4391-thread-2)
[n:127.0.0.1:39497_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.cloud.autoscaling.IndexSizeTriggerTest_5E0761BC730CB21D-001/tempDir-001/node2
[junit4] 2> 517494 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
[junit4] 2> 517495 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 517513 INFO (zkConnectionManagerCallback-4446-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 517513 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 517520 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 517523 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36223/solr ready
[junit4] 2> 517555 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and
.scheduled_maintenance triggers
[junit4] 2> 517555 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode
version 1
[junit4] 2> 517555 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 0
[junit4] 2> 517555 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
[junit4] 2> 517555 DEBUG
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.a.s.SimClusterStateProvider --- new Overseer leader:
127.0.0.1:10009_solr
[junit4] 2> 517556 DEBUG
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states,
currentVersion=0
[junit4] 2> 517556 DEBUG
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 0
[junit4] 2> 517556 INFO
(SUITE-IndexSizeTriggerTest-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history
in memory.
[junit4] 2> 517559 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial
livenodes: [127.0.0.1:10010_solr, 127.0.0.1:10009_solr]
[junit4] 2> 517560 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded
markers
[junit4] 2> 517560 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
[junit4] 2> 517560 DEBUG (ScheduledTrigger-4449-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 517581 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 517601 DEBUG (ScheduledTrigger-4449-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 517622 DEBUG (ScheduledTrigger-4449-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 517642 DEBUG (ScheduledTrigger-4449-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 517662 DEBUG (ScheduledTrigger-4449-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 517683 DEBUG (ScheduledTrigger-4449-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 517703 DEBUG (ScheduledTrigger-4449-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 517724 DEBUG (ScheduledTrigger-4449-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 517744 DEBUG (ScheduledTrigger-4449-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 517764 DEBUG (ScheduledTrigger-4449-thread-3) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 517783 INFO
(TEST-IndexSizeTriggerTest.testMaxOps-seed#[5E0761BC730CB21D]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testMaxOps
[junit4] 2> 517785 DEBUG (ScheduledTrigger-4449-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 517804 DEBUG (simCloudManagerPool-4448-thread-1) [ ]
o.a.s.c.a.s.SimClusterStateProvider -- simCreateCollection
testMaxOps_collection, currentVersion=1
[junit4] 2> 517805 DEBUG (simCloudManagerPool-4448-thread-1) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states,
currentVersion=1
[junit4] 2> 517806 DEBUG (ScheduledTrigger-4449-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 517806 DEBUG (simCloudManagerPool-4448-thread-1) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 1
[junit4] 2> 517819 DEBUG (simCloudManagerPool-4448-thread-1) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states,
currentVersion=2
[junit4] 2> 517821 DEBUG (simCloudManagerPool-4448-thread-1) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 2
[junit4] 2> 517826 DEBUG (ScheduledTrigger-4449-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 517846 DEBUG (ScheduledTrigger-4449-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 517856 DEBUG (simCloudManagerPool-4448-thread-2) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states,
currentVersion=3
[junit4] 2> 517856 DEBUG (simCloudManagerPool-4448-thread-2) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 3
[junit4] 2> 517856 DEBUG (simCloudManagerPool-4448-thread-2) [ ]
o.a.s.c.a.s.SimClusterStateProvider Running leader election
(testMaxOps_collection / shard1)
[junit4] 2> 517956 DEBUG (ScheduledTrigger-4449-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 517857 DEBUG (simCloudManagerPool-4448-thread-2) [ ]
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for
testMaxOps_collection / shard1 (currentVersion=4): {"core_node1":{}}
[junit4] 2> 517968 DEBUG (simCloudManagerPool-4448-thread-4) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states,
currentVersion=4
[junit4] 2> 517969 DEBUG (simCloudManagerPool-4448-thread-4) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 4
[junit4] 2> 517969 DEBUG (simCloudManagerPool-4448-thread-4) [ ]
o.a.s.c.a.s.SimClusterStateProvider Running leader election
(testMaxOps_collection / shard2)
[junit4] 2> 517969 DEBUG (simCloudManagerPool-4448-thread-4) [ ]
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for
testMaxOps_collection / shard2 (currentVersion=5): {"core_node3":{}}
[junit4] 2> 517976 DEBUG (ScheduledTrigger-4449-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 517980 DEBUG (simCloudManagerPool-4448-thread-3) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states,
currentVersion=5
[junit4] 2> 517981 DEBUG (simCloudManagerPool-4448-thread-3) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 5
[junit4] 2> 517991 DEBUG (simCloudManagerPool-4448-thread-5) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states,
currentVersion=6
[junit4] 2> 517992 DEBUG (simCloudManagerPool-4448-thread-5) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 6
[junit4] 2> 517996 DEBUG (ScheduledTrigger-4449-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518002 DEBUG (simCloudManagerPool-4448-thread-6) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states,
currentVersion=7
[junit4] 2> 518003 DEBUG (simCloudManagerPool-4448-thread-6) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 7
[junit4] 2> 518003 DEBUG (simCloudManagerPool-4448-thread-6) [ ]
o.a.s.c.a.s.SimClusterStateProvider Running leader election
(testMaxOps_collection / shard3)
[junit4] 2> 518003 DEBUG (simCloudManagerPool-4448-thread-6) [ ]
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for
testMaxOps_collection / shard3 (currentVersion=8): {"core_node5":{}}
[junit4] 2> 518013 DEBUG (simCloudManagerPool-4448-thread-7) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states,
currentVersion=8
[junit4] 2> 518014 DEBUG (simCloudManagerPool-4448-thread-7) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 8
[junit4] 2> 518017 DEBUG (ScheduledTrigger-4449-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518024 DEBUG (simCloudManagerPool-4448-thread-8) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states,
currentVersion=9
[junit4] 2> 518028 DEBUG (simCloudManagerPool-4448-thread-8) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 9
[junit4] 2> 518028 DEBUG (simCloudManagerPool-4448-thread-8) [ ]
o.a.s.c.a.s.SimClusterStateProvider Running leader election
(testMaxOps_collection / shard4)
[junit4] 2> 518028 DEBUG (simCloudManagerPool-4448-thread-8) [ ]
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for
testMaxOps_collection / shard4 (currentVersion=10): {"core_node7":{}}
[junit4] 2> 518037 DEBUG (ScheduledTrigger-4449-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518038 DEBUG (simCloudManagerPool-4448-thread-10) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states,
currentVersion=10
[junit4] 2> 518039 DEBUG (simCloudManagerPool-4448-thread-10) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 10
[junit4] 2> 518039 DEBUG (simCloudManagerPool-4448-thread-10) [ ]
o.a.s.c.a.s.SimClusterStateProvider Running leader election
(testMaxOps_collection / shard5)
[junit4] 2> 518039 DEBUG (simCloudManagerPool-4448-thread-10) [ ]
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for
testMaxOps_collection / shard5 (currentVersion=11): {"core_node9":{}}
[junit4] 2> 518040 DEBUG (simCloudManagerPool-4448-thread-1) [ ]
o.a.s.c.a.s.SimClusterStateProvider -- finished createCollection
testMaxOps_collection, currentVersion=11
[junit4] 2> 518050 DEBUG (simCloudManagerPool-4448-thread-9) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states,
currentVersion=11
[junit4] 2> 518051 DEBUG (simCloudManagerPool-4448-thread-9) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 11
[junit4] 2> 518057 DEBUG (ScheduledTrigger-4449-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518061 DEBUG (simCloudManagerPool-4448-thread-11) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states,
currentVersion=12
[junit4] 2> 518061 DEBUG (simCloudManagerPool-4448-thread-11) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 12
[junit4] 2> 518062 DEBUG
(TEST-IndexSizeTriggerTest.testMaxOps-seed#[5E0761BC730CB21D]) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states,
currentVersion=13
[junit4] 2> 518062 DEBUG
(TEST-IndexSizeTriggerTest.testMaxOps-seed#[5E0761BC730CB21D]) [ ]
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 13
[junit4] 2> 518073 DEBUG (simCloudManagerPool-4448-thread-12) [ ]
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 518074 DEBUG (simCloudManagerPool-4448-thread-12) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
2
[junit4] 2> 518076 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
[junit4] 2> 518076 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded
markers
[junit4] 2> 518076 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
[junit4] 2> 518078 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518080 DEBUG (simCloudManagerPool-4448-thread-13) [ ]
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 518080 DEBUG (simCloudManagerPool-4448-thread-13) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
3
[junit4] 2> 518080 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 3
[junit4] 2> 518080 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded
markers
[junit4] 2> 518080 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion 3
[junit4] 2> 518083 DEBUG (simCloudManagerPool-4448-thread-14) [ ]
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 518084 DEBUG (simCloudManagerPool-4448-thread-14) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
4
[junit4] 2> 518084 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 4
[junit4] 2> 518084 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded
markers
[junit4] 2> 518084 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 4, lastZnodeVersion 4
[junit4] 2> 518098 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518118 DEBUG (ScheduledTrigger-4449-thread-3) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518123 DEBUG (ScheduledTrigger-4428-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 1
[junit4] 2> 518138 DEBUG (ScheduledTrigger-4449-thread-3) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518219 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518251 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518271 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518291 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518311 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518332 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518352 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518372 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518392 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518412 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518433 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518453 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518473 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518576 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518597 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518618 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518638 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518659 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518679 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518692 DEBUG (simCloudManagerPool-4448-thread-200) [ ]
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 518692 DEBUG (simCloudManagerPool-4448-thread-200) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
5
[junit4] 2> 518693 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 5
[junit4] 2> 518693 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded
markers
[junit4] 2> 518693 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 5, lastZnodeVersion 5
[junit4] 2> 518699 DEBUG (ScheduledTrigger-4449-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518720 DEBUG (ScheduledTrigger-4449-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518740 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518760 DEBUG (ScheduledTrigger-4449-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518781 DEBUG (ScheduledTrigger-4449-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518801 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518821 DEBUG (ScheduledTrigger-4449-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518841 DEBUG (ScheduledTrigger-4449-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2 and last live nodes: 2
[junit4] 2> 518845 DEBUG (ScheduledTrigger-4449-thread-2) [ ]
o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown inactive - processing event: {
[junit4] 2> "id":"1cbb21e64eff7bT9fgo8fsje46ukzid6l33ma7io",
[junit4] 2> "source":"index_size_trigger5",
[junit4] 2> "eventTime":8087053620150139,
[junit4] 2> "eventType":"INDEXSIZE",
[junit4] 2> "properties":{
[junit4] 2> "aboveSize":{
[junit4] 2> "testMaxOps_collection_shard1_replica_n1":"docs=38,
bytes=88064",
[junit4] 2> "testMaxOps_collection_shard2_replica_n3":"docs=38,
bytes=88064",
[junit4] 2> "testMaxOps_collection_shard3_replica_n5":"docs=30,
bytes=71680",
[junit4] 2> "testMaxOps_collection_shard4_replica_n7":"docs=46,
bytes=104448",
[junit4] 2> "testMaxOps_collection_shard5_replica_n9":"docs=48,
bytes=108544"},
[junit4] 2> "belowSize":{},
[junit4] 2> "requestedOps":[
[junit4] 2> {
[junit4] 2> "action":"SPLITSHARD",
[junit4] 2> "hints":{
[junit4] 2> "COLL_SHARD":[{
[junit4] 2> "first":"testMaxOps_collection",
[junit4] 2> "second":"shard5"}],
[junit4] 2> "PARAMS":{
[junit4] 2> "splitByPrefix":false,
[junit4] 2> "splitMethod":"link"}}},
[junit4] 2> {
[junit4] 2> "action":"SPLITSHARD",
[junit4] 2> "hints":{
[junit4] 2> "COLL_SHARD":[{
[junit4] 2> "first":"testMaxOps_collection",
[junit4] 2> "second":"shard4"}],
[junit4] 2> "PARAMS":{
[junit4] 2> "splitByPrefix":false,
[junit4] 2> "splitMethod":"link"}}},
[junit4] 2> {
[junit4] 2> "action":"SPLITSHARD",
[junit4] 2> "hints":{
[junit4] 2> "COLL_SHARD":[{
[junit4] 2> "first":"testMaxOps_collection",
[junit4] 2> "second":"shard2"}],
[junit4] 2> "PARAMS":{
[junit4] 2> "splitByPrefix":false,
[junit4] 2> "splitMethod":"link"}}},
[junit4] 2> {
[junit4] 2> "action":"SPLITSHARD",
[junit4] 2> "hints":{
[junit4] 2> "COLL_SHARD":[{
[junit4] 2> "first":"testMaxOps_collection",
[junit4] 2> "second":"shard1"}],
[junit4] 2> "PARAMS":{
[junit4] 2> "splitByPrefix":false,
[junit4] 2> "splitMethod":"link"}}},
[junit4] 2> {
[junit4] 2> "action":"SPLITSHARD",
[junit4] 2> "hints":{
[junit4] 2> "COLL_SHARD":[{
[junit4] 2> "first":"testMaxOps_collection",
[junit4] 2> "second":"shard3"}],
[junit4] 2> "PARAMS":{
[junit4] 2> "splitByPrefix":false,
[junit4] 2> "splitMethod":"link"}}}]}}
[junit4] 2> 518846 DEBUG (ScheduledTrigger-4449-thread-2) [ ]
o.a.s.c.a.ScheduledTriggers Pausing all triggers: [index_size_trigger5,
.auto_add_replicas, .scheduled_maintenance]
[junit4] 2> 518847 DEBUG (ScheduledTrigger-4449-thread-2) [ ]
o.a.s.c.a.SystemLogListener Collection .system missing, skip sending event {
[junit4] 2> "id":"1cbb21e64eff7bT9fgo8fsje46ukzid6l33ma7io",
[junit4] 2> "source":"index_size_trigger5",
[junit4] 2> "eventTime":8087053620150139,
[junit4] 2> "eventType":"INDEXSIZE",
[junit4] 2> "properties":{
[junit4] 2> "aboveSize":{
[junit4] 2> "testMaxOps_collection_shard1_replica_n1":"docs=38,
bytes=88064",
[junit4] 2> "testMaxOps_collection_shard2_replica_n3":"docs=38,
bytes=88064",
[junit4] 2> "testMaxOps_collection_shard3_replica_n5":"docs=30,
bytes=71680",
[junit4] 2> "testMaxOps_collection_shard4_replica_n7":"docs=46,
bytes=104448",
[junit4] 2> "testMaxOps_collection_shard5_replica_n9":"docs=48,
bytes=108544"},
[junit4] 2> "belowSize":{},
[junit4] 2> "_enqueue_time_":8087061163329239,
[junit4] 2> "requestedOps":[
[junit4] 2> {
[junit4] 2> "action":"SPLITSHARD",
[junit4] 2> "hints":{
[...truncated too long message...]
tractConnector Stopped ServerConnector@2169e08d{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 1506912 INFO (jetty-closer-14529-thread-4) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@20a80b8c{/solr,null,STOPPED}
[junit4] 2> 1506912 INFO (jetty-closer-14529-thread-4) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1507009 INFO (jetty-closer-14529-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72586906220757010-127.0.0.1:37697_solr-n_0000000004) closing
[junit4] 2> 1507010 INFO (jetty-closer-14529-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@3107ce52{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 1507011 INFO (jetty-closer-14529-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@69a2542f{/solr,null,STOPPED}
[junit4] 2> 1507011 INFO (jetty-closer-14529-thread-1) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1507111 INFO (jetty-closer-14529-thread-3) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@38700825{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 1507111 INFO (jetty-closer-14529-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@7b54bb1a{/solr,null,STOPPED}
[junit4] 2> 1507112 INFO (jetty-closer-14529-thread-3) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1507112 INFO
(SUITE-TestPullReplicaErrorHandling-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 1507214 WARN
(SUITE-TestPullReplicaErrorHandling-seed#[5E0761BC730CB21D]-worker-SendThread(127.0.0.1:38825))
[ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for
session 0x101e16818a20001.
[junit4] 2> => EndOfStreamException: Unable to read additional
data from server sessionid 0x101e16818a20001, likely server has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable
to read additional data from server sessionid 0x101e16818a20001, likely server
has closed socket
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350)
~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275)
[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 1507316 WARN (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 13 /solr/aliases.json
[junit4] 2> 12 /solr/security.json
[junit4] 2> 9
/solr/collections/pull_replica_error_handling_test_close_hooks_deleted_on_reconnect/terms/shard1
[junit4] 2> 9
/solr/collections/pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper/terms/shard1
[junit4] 2> 9 /solr/configs/conf
[junit4] 2> 9 /solr/clusterprops.json
[junit4] 2> 8 /solr/packages.json
[junit4] 2> 7
/solr/collections/pull_replica_error_handling_test_cant_connect_to_leader/terms/shard1
[junit4] 2> 6
/solr/collections/pull_replica_error_handling_test_cant_connect_to_leader/state.json
[junit4] 2> 6
/solr/collections/pull_replica_error_handling_test_close_hooks_deleted_on_reconnect/state.json
[junit4] 2> 4
/solr/collections/pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper/state.json
[junit4] 2> 2
/solr/collections/pull_replica_error_handling_test_cant_connect_to_leader/collectionprops.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 49
/solr/collections/pull_replica_error_handling_test_close_hooks_deleted_on_reconnect/state.json
[junit4] 2> 31
/solr/collections/pull_replica_error_handling_test_pull_replica_disconnects_from_zoo_keeper/state.json
[junit4] 2> 26
/solr/collections/pull_replica_error_handling_test_cant_connect_to_leader/state.json
[junit4] 2> 13 /solr/clusterstate.json
[junit4] 2> 9 /solr/clusterprops.json
[junit4] 2> 5 /solr/autoscaling.json
[junit4] 2> 3
/solr/overseer_elect/election/72586906220757019-127.0.0.1:42443_solr-n_0000000007
[junit4] 2> 2
/solr/overseer_elect/election/72586906220757013-127.0.0.1:44131_solr-n_0000000005
[junit4] 2> 2
/solr/overseer_elect/election/72586906220757002-127.0.0.1:45857_solr-n_0000000000
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 100 /solr/live_nodes
[junit4] 2> 90 /solr/overseer/queue
[junit4] 2> 51 /solr/collections
[junit4] 2> 29 /solr/overseer/collection-queue-work
[junit4] 2> 5 /solr/autoscaling/events/.scheduled_maintenance
[junit4] 2> 5 /solr/autoscaling/events/.auto_add_replicas
[junit4] 2> 5 /solr/overseer/queue-work
[junit4] 2>
[junit4] 2> 1507319 INFO
(SUITE-TestPullReplicaErrorHandling-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:38825
[junit4] 2> 1507319 INFO
(SUITE-TestPullReplicaErrorHandling-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:38825
[junit4] 2> 1507319 INFO
(SUITE-TestPullReplicaErrorHandling-seed#[5E0761BC730CB21D]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1 38825
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.cloud.TestPullReplicaErrorHandling_5E0761BC730CB21D-001
[junit4] 2> Dec 03, 2020 9:21:36 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene87):
{_root_=Lucene84, fieldName_s=BlockTreeOrds(blocksize=128),
id=PostingsFormat(name=LuceneFixedGap)}, docValues:{},
maxPointsInLeafNode=1488, maxMBSortInHeap=5.136643994815923,
sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=lv-LV,
timezone=America/North_Dakota/New_Salem
[junit4] 2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation
1.8.0_252 (64-bit)/cpus=4,threads=1,free=250084120,total=530055168
[junit4] 2> NOTE: All tests run in this JVM:
[AsyncCallRequestStatusResponseTest, ByteBuffersDirectoryFactoryTest,
TestManagedResourceStorage, FileBasedSpellCheckerTest,
DistributedDebugComponentTest, TestUninvertingReader,
TestDistributedMissingSort, TestCustomSort, TestSweetSpotSimilarityFactory,
BasicZkTest, FullSolrCloudDistribCmdsTest, IndexSchemaRuntimeFieldTest,
TestExpandComponent, HttpTriggerListenerTest, BadIndexSchemaTest,
TestCloudNestedDocsSort, BlockCacheTest, TestPushWriter,
TestSlowCompositeReaderWrapper, TestCSVLoader, DirectSolrConnectionTest,
AtomicUpdatesTest, TestRebalanceLeaders, TestDocBasedVersionConstraints,
InfixSuggestersTest, BitVectorTest, TestMergePolicyConfig,
ClusterStateMockUtilTest, TermVectorComponentDistributedTest,
MetricsConfigTest, SolrIndexConfigTest, TriggerEventQueueTest,
SuggesterFSTTest, MergeStrategyTest, TestConfigOverlay, MultiThreadedOCPTest,
TestFieldCacheWithThreads, RankQueryTest, V2ApiIntegrationTest, SyncSliceTest,
TestHighlightDedupGrouping, TestDFRSimilarityFactory, TestCoreContainer,
ChaosMonkeySafeLeaderWithPullReplicasTest, TestSimExtremeIndexing,
DeleteNodeTest, NumericFieldsTest, UtilsToolTest, TestManagedStopFilterFactory,
TestMiniSolrCloudClusterSSL, TestHdfsBackupRestoreCore, AuditLoggerPluginTest,
DistributedMLTComponentTest, HdfsBasicDistributedZkTest, DOMUtilTest,
TestAnalyzeInfixSuggestions, TestReplicaProperties,
DistributedUpdateProcessorTest, TestFieldCacheReopen, DataDrivenBlockJoinTest,
DocValuesMultiTest, AnalysisAfterCoreReloadTest, TestZkChroot,
SortByFunctionTest, DistributedFacetPivotLongTailTest,
TestCollapseQParserPlugin, Tagger2Test, TestSolrFieldCacheBean,
MoveReplicaHDFSFailoverTest, HLLUtilTest, TestMaxScoreQueryParser,
TestExportWriter, TestStressUserVersions, SortSpecParsingTest,
TestQuerySenderNoQuery, HdfsRecoverLeaseTest, TestSolrQueryResponse,
SolrMetricReporterTest, TestReqParamsAPI, DirectoryFactoriesTest,
TestSortByMinMaxFunction, HighlighterWithoutStoredIdTest, RouteFieldTest,
UpdateRequestProcessorFactoryTest, TestSimUtils, TestInitQParser,
TestCollectionAPI, DistributedVersionInfoTest, TestJsonFacets,
ScheduledMaintenanceTriggerTest, OutputWriterTest,
TestTolerantUpdateProcessorRandomCloud, CollectionStateFormat2Test,
ReplaceNodeTest, SearchRateTriggerTest, SpellCheckComponentTest,
RecoveryZkTest, TestSimpleTrackingShardHandler, TestDistributedTracing,
DistributedFacetSimpleRefinementLongTailTest, ResourceLoaderTest,
TestExactSharedStatsCache, TestExportTool, CreateCollectionCleanupTest,
DocumentAnalysisRequestHandlerTest, TestRandomCollapseQParserPlugin,
TestInPlaceUpdatesRequiredField, TestStandardQParsers, TestPseudoReturnFields,
LukeRequestHandlerTest, TestFieldTypeCollectionResource,
TestLegacyNumericUtils, AssignBackwardCompatibilityTest,
ChaosMonkeySafeLeaderTest, DistribDocExpirationUpdateProcessorTest,
LeaderFailureAfterFreshStartTest, MigrateRouteKeyTest,
OverseerSolrResponseTest, OverseerSolrResponseUnsafeSerializationTest,
PackageManagerCLITest, ShardRoutingCustomTest, SolrCLIZkUtilsTest,
SolrCloudExampleTest, TestCloudDeleteByQuery, TestCloudRecovery,
TestConfigSetsAPIZkFailure, TestDistributedMap, TestDownShardTolerantSearch,
TestDynamicFieldNamesIndexCorrectly, TestExclusionRuleCollectionAccess,
TestHashPartitioner, TestLockTree, TestPullReplicaErrorHandling]
[junit4] Completed [545/922 (2!)] on J0 in 27.25s, 4 tests, 1 error <<<
FAILURES!
[...truncated 52067 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
