[JENKINS] Lucene » Lucene-Solr-NightlyTests-8.x - Build # 404 - Still Unstable!

[Apache Jenkins Server]

Build: 
https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-NightlyTests-8.x/404/

1 tests failed.
FAILED:  
org.apache.solr.cloud.DocValuesNotIndexedTest.testGroupingDVOnlySortFirst

Error Message:
Unexpected number of elements in the group for 'intGSF' size: '5' GroupValue: 
'656787505' rsp: 
{responseHeader={zkConnected=true,status=0,QTime=7,params={q=*:*,group.sort=id 
asc,_stateVer_=dv_coll:3,group.limit=100,rows=100,wt=javabin,version=2,group.field=intGSF,group=true}},grouped={intGSF={matches=46,groups=[{groupValue=656787505,doclist={numFound=5,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=0,
 intGSF=656787505, longGSF=4504755606069861424, doubleGSF=499.2749178344455, 
floatGSF=4652.1216, dateGSF=Tue Apr 27 08:37:34 GMT 50460483, 
stringGSF=base_string_762373__00006954, boolGSF=true, 
sortableGSF=base_string_762408__00002837, _version_=1712067671144529920, 
_root_=0}, SolrDocument{id=1, intGSF=656787505, longGSF=4504755606069861424, 
doubleGSF=499.2749178344455, floatGSF=4652.1216, dateGSF=Tue Apr 27 08:37:34 
GMT 50460483, stringGSF=base_string_762373__00006954, boolGSF=false, 
sortableGSF=base_string_762408__00002837, _version_=1712067671143481344, 
_root_=1}, SolrDocument{id=2, intGSF=656787505, longGSF=4504755606069861424, 
doubleGSF=499.2749178344455, floatGSF=4652.1216, dateGSF=Tue Apr 27 08:37:34 
GMT 50460483, stringGSF=base_string_762373__00006954, boolGSF=true, 
sortableGSF=base_string_762408__00002837, _version_=1712067671146627072, 
_root_=2}, SolrDocument{id=4, intGSF=656787505, longGSF=4504755606069861424, 
doubleGSF=499.2749178344455, floatGSF=4652.1216, dateGSF=Tue Apr 27 08:37:34 
GMT 50460483, stringGSF=base_string_762373__00006954, boolGSF=true, 
sortableGSF=base_string_762408__00002837, _version_=1712067671145578496, 
_root_=4}, SolrDocument{id=5, intGSF=656787505, longGSF=4504755606069861424, 
doubleGSF=499.2749178344455, floatGSF=4652.1216, dateGSF=Tue Apr 27 08:37:34 
GMT 50460483, stringGSF=base_string_762373__00006954, boolGSF=false, 
sortableGSF=base_string_762408__00002837, _version_=1712067671142432768, 
_root_=5}]}}, 
{groupValue=656791825,doclist={numFound=5,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=10,
 intGSF=656791825, longGSF=4504755606069863831, doubleGSF=8770.274917834446, 
floatGSF=7999.1216, dateGSF=Tue Apr 27 08:37:35 GMT 50460483, 
stringGSF=base_string_762373__00010370, boolGSF=true, 
sortableGSF=base_string_762408__00004413, _version_=1712067671145578497, 
_root_=10}, SolrDocument{id=11, intGSF=656791825, longGSF=4504755606069863831, 
doubleGSF=8770.274917834446, floatGSF=7999.1216, dateGSF=Tue Apr 27 08:37:35 
GMT 50460483, stringGSF=base_string_762373__00010370, boolGSF=false, 
sortableGSF=base_string_762408__00004413, _version_=1712067671145578498, 
_root_=11}, SolrDocument{id=12, intGSF=656791825, longGSF=4504755606069863831, 
doubleGSF=8770.274917834446, floatGSF=7999.1216, dateGSF=Tue Apr 27 08:37:35 
GMT 50460483, stringGSF=base_string_762373__00010370, boolGSF=true, 
sortableGSF=base_string_762408__00004413, _version_=1712067671145578498, 
_root_=12}, SolrDocument{id=13, intGSF=656791825, longGSF=4504755606069863831, 
doubleGSF=8770.274917834446, floatGSF=7999.1216, dateGSF=Tue Apr 27 08:37:35 
GMT 50460483, stringGSF=base_string_762373__00010370, boolGSF=false, 
sortableGSF=base_string_762408__00004413, _version_=1712067671145578499, 
_root_=13}, SolrDocument{id=8, intGSF=656791825, longGSF=4504755606069863831, 
doubleGSF=8770.274917834446, floatGSF=7999.1216, dateGSF=Tue Apr 27 08:37:35 
GMT 50460483, stringGSF=base_string_762373__00010370, boolGSF=true, 
sortableGSF=base_string_762408__00004413, _version_=1712067671145578496, 
_root_=8}]}}, 
{groupValue=656800507,doclist={numFound=6,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=14,
 intGSF=656800507, longGSF=4504755606069870133, doubleGSF=9291.274917834446, 
floatGSF=10356.122, dateGSF=Tue Apr 27 08:37:42 GMT 50460483, 
stringGSF=base_string_762373__00015939, boolGSF=true, 
sortableGSF=base_string_762408__00004467, _version_=1712067671145578500, 
_root_=14}, SolrDocument{id=15, intGSF=656800507, longGSF=4504755606069870133, 
doubleGSF=9291.274917834446, floatGSF=10356.122, dateGSF=Tue Apr 27 08:37:42 
GMT 50460483, stringGSF=base_string_762373__00015939, boolGSF=false, 
sortableGSF=base_string_762408__00004467, _version_=1712067671145578499, 
_root_=15}, SolrDocument{id=16, intGSF=656800507, longGSF=4504755606069870133, 
doubleGSF=9291.274917834446, floatGSF=10356.122, dateGSF=Tue Apr 27 08:37:42 
GMT 50460483, stringGSF=base_string_762373__00015939, boolGSF=true, 
sortableGSF=base_string_762408__00004467, _version_=1712067671145578500, 
_root_=16}, SolrDocument{id=17, intGSF=656800507, longGSF=4504755606069870133, 
doubleGSF=9291.274917834446, floatGSF=10356.122, dateGSF=Tue Apr 27 08:37:42 
GMT 50460483, stringGSF=base_string_762373__00015939, boolGSF=false, 
sortableGSF=base_string_762408__00004467, _version_=1712067671142432769, 
_root_=17}, SolrDocument{id=19, intGSF=656800507, longGSF=4504755606069870133, 
doubleGSF=9291.274917834446, floatGSF=10356.122, dateGSF=Tue Apr 27 08:37:42 
GMT 50460483, stringGSF=base_string_762373__00015939, boolGSF=false, 
sortableGSF=base_string_762408__00004467, _version_=1712067671142432770, 
_root_=19}, SolrDocument{id=20, intGSF=656800507, longGSF=4504755606069870133, 
doubleGSF=9291.274917834446, floatGSF=10356.122, dateGSF=Tue Apr 27 08:37:42 
GMT 50460483, stringGSF=base_string_762373__00015939, boolGSF=true, 
sortableGSF=base_string_762408__00004467, _version_=1712067671145578501, 
_root_=20}]}}, 
{groupValue=null,doclist={numFound=6,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=10000,
 _version_=1712067671139287040, _root_=10000}, SolrDocument{id=10005, 
_version_=1712067671145578497, _root_=10005}, SolrDocument{id=10015, 
_version_=1712067671145578501, _root_=10015}, SolrDocument{id=10020, 
_version_=1712067671145578502, _root_=10020}, SolrDocument{id=10030, 
_version_=1712067671142432775, _root_=10030}, SolrDocument{id=10040, 
_version_=1712067671142432778, _root_=10040}]}}, 
{groupValue=656802647,doclist={numFound=6,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=21,
 intGSF=656802647, longGSF=4504755606069875044, doubleGSF=11407.274917834446, 
floatGSF=15912.122, dateGSF=Tue Apr 27 08:37:45 GMT 50460483, 
stringGSF=base_string_762373__00021949, boolGSF=false, 
sortableGSF=base_string_762408__00009604, _version_=1712067671142432771, 
_root_=21}, SolrDocument{id=22, intGSF=656802647, longGSF=4504755606069875044, 
doubleGSF=11407.274917834446, floatGSF=15912.122, dateGSF=Tue Apr 27 08:37:45 
GMT 50460483, stringGSF=base_string_762373__00021949, boolGSF=true, 
sortableGSF=base_string_762408__00009604, _version_=1712067671145578502, 
_root_=22}, SolrDocument{id=23, intGSF=656802647, longGSF=4504755606069875044, 
doubleGSF=11407.274917834446, floatGSF=15912.122, dateGSF=Tue Apr 27 08:37:45 
GMT 50460483, stringGSF=base_string_762373__00021949, boolGSF=false, 
sortableGSF=base_string_762408__00009604, _version_=1712067671142432772, 
_root_=23}, SolrDocument{id=24, intGSF=656802647, longGSF=4504755606069875044, 
doubleGSF=11407.274917834446, floatGSF=15912.122, dateGSF=Tue Apr 27 08:37:45 
GMT 50460483, stringGSF=base_string_762373__00021949, boolGSF=true, 
sortableGSF=base_string_762408__00009604, _version_=1712067671145578503, 
_root_=24}, SolrDocument{id=25, intGSF=656802647, longGSF=4504755606069875044, 
doubleGSF=11407.274917834446, floatGSF=15912.122, dateGSF=Tue Apr 27 08:37:45 
GMT 50460483, stringGSF=base_string_762373__00021949, boolGSF=false, 
sortableGSF=base_string_762408__00009604, _version_=1712067671142432773, 
_root_=25}, SolrDocument{id=27, intGSF=656802647, longGSF=4504755606069875044, 
doubleGSF=11407.274917834446, floatGSF=15912.122, dateGSF=Tue Apr 27 08:37:45 
GMT 50460483, stringGSF=base_string_762373__00021949, boolGSF=false, 
sortableGSF=base_string_762408__00009604, _version_=1712067671145578504, 
_root_=27}]}}, 
{groupValue=656810943,doclist={numFound=5,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=28,
 intGSF=656810943, longGSF=4504755606069881261, doubleGSF=15027.274917834446, 
floatGSF=21214.121, dateGSF=Tue Apr 27 08:37:47 GMT 50460483, 
stringGSF=base_string_762373__00031351, boolGSF=true, 
sortableGSF=base_string_762408__00010467, _version_=1712067671145578505, 
_root_=28}, SolrDocument{id=29, intGSF=656810943, longGSF=4504755606069881261, 
doubleGSF=15027.274917834446, floatGSF=21214.121, dateGSF=Tue Apr 27 08:37:47 
GMT 50460483, stringGSF=base_string_762373__00031351, boolGSF=false, 
sortableGSF=base_string_762408__00010467, _version_=1712067671142432774, 
_root_=29}, SolrDocument{id=32, intGSF=656810943, longGSF=4504755606069881261, 
doubleGSF=15027.274917834446, floatGSF=21214.121, dateGSF=Tue Apr 27 08:37:47 
GMT 50460483, stringGSF=base_string_762373__00031351, boolGSF=true, 
sortableGSF=base_string_762408__00010467, _version_=1712067671145578506, 
_root_=32}, SolrDocument{id=33, intGSF=656810943, longGSF=4504755606069881261, 
doubleGSF=15027.274917834446, floatGSF=21214.121, dateGSF=Tue Apr 27 08:37:47 
GMT 50460483, stringGSF=base_string_762373__00031351, boolGSF=false, 
sortableGSF=base_string_762408__00010467, _version_=1712067671142432776, 
_root_=33}, SolrDocument{id=34, intGSF=656810943, longGSF=4504755606069881261, 
doubleGSF=15027.274917834446, floatGSF=21214.121, dateGSF=Tue Apr 27 08:37:47 
GMT 50460483, stringGSF=base_string_762373__00031351, boolGSF=true, 
sortableGSF=base_string_762408__00010467, _version_=1712067671146627072, 
_root_=34}]}}, 
{groupValue=656814052,doclist={numFound=6,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=35,
 intGSF=656814052, longGSF=4504755606069883827, doubleGSF=15587.274917834446, 
floatGSF=22017.121, dateGSF=Tue Apr 27 08:37:55 GMT 50460483, 
stringGSF=base_string_762373__00034599, boolGSF=false, 
sortableGSF=base_string_762408__00016833, _version_=1712067671146627073, 
_root_=35}, SolrDocument{id=36, intGSF=656814052, longGSF=4504755606069883827, 
doubleGSF=15587.274917834446, floatGSF=22017.121, dateGSF=Tue Apr 27 08:37:55 
GMT 50460483, stringGSF=base_string_762373__00034599, boolGSF=true, 
sortableGSF=base_string_762408__00016833, _version_=1712067671146627074, 
_root_=36}, SolrDocument{id=37, intGSF=656814052, longGSF=4504755606069883827, 
doubleGSF=15587.274917834446, floatGSF=22017.121, dateGSF=Tue Apr 27 08:37:55 
GMT 50460483, stringGSF=base_string_762373__00034599, boolGSF=false, 
sortableGSF=base_string_762408__00016833, _version_=1712067671142432777, 
_root_=37}, SolrDocument{id=38, intGSF=656814052, longGSF=4504755606069883827, 
doubleGSF=15587.274917834446, floatGSF=22017.121, dateGSF=Tue Apr 27 08:37:55 
GMT 50460483, stringGSF=base_string_762373__00034599, boolGSF=true, 
sortableGSF=base_string_762408__00016833, _version_=1712067671145578507, 
_root_=38}, SolrDocument{id=40, intGSF=656814052, longGSF=4504755606069883827, 
doubleGSF=15587.274917834446, floatGSF=22017.121, dateGSF=Tue Apr 27 08:37:55 
GMT 50460483, stringGSF=base_string_762373__00034599, boolGSF=true, 
sortableGSF=base_string_762408__00016833, _version_=1712067671145578508, 
_root_=40}, SolrDocument{id=41, intGSF=656814052, longGSF=4504755606069883827, 
doubleGSF=15587.274917834446, floatGSF=22017.121, dateGSF=Tue Apr 27 08:37:55 
GMT 50460483, stringGSF=base_string_762373__00034599, boolGSF=false, 
sortableGSF=base_string_762408__00016833, _version_=1712067671146627075, 
_root_=41}]}}, 
{groupValue=656817280,doclist={numFound=7,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=42,
 intGSF=656817280, longGSF=4504755606069887992, doubleGSF=16695.274917834446, 
floatGSF=28231.121, dateGSF=Tue Apr 27 08:38:02 GMT 50460483, 
stringGSF=base_string_762373__00044251, boolGSF=true, 
sortableGSF=base_string_762408__00018553, _version_=1712067671146627072, 
_root_=42}, SolrDocument{id=43, intGSF=656817280, longGSF=4504755606069887992, 
doubleGSF=16695.274917834446, floatGSF=28231.121, dateGSF=Tue Apr 27 08:38:02 
GMT 50460483, stringGSF=base_string_762373__00044251, boolGSF=false, 
sortableGSF=base_string_762408__00018553, _version_=1712067671146627076, 
_root_=43}, SolrDocument{id=44, intGSF=656817280, longGSF=4504755606069887992, 
doubleGSF=16695.274917834446, floatGSF=28231.121, dateGSF=Tue Apr 27 08:38:02 
GMT 50460483, stringGSF=base_string_762373__00044251, boolGSF=true, 
sortableGSF=base_string_762408__00018553, _version_=1712067671146627077, 
_root_=44}, SolrDocument{id=45, intGSF=656817280, longGSF=4504755606069887992, 
doubleGSF=16695.274917834446, floatGSF=28231.121, dateGSF=Tue Apr 27 08:38:02 
GMT 50460483, stringGSF=base_string_762373__00044251, boolGSF=false, 
sortableGSF=base_string_762408__00018553, _version_=1712067671143481344, 
_root_=45}, SolrDocument{id=46, intGSF=656817280, longGSF=4504755606069887992, 
doubleGSF=16695.274917834446, floatGSF=28231.121, dateGSF=Tue Apr 27 08:38:02 
GMT 50460483, stringGSF=base_string_762373__00044251, boolGSF=true, 
sortableGSF=base_string_762408__00018553, _version_=1712067671146627078, 
_root_=46}, SolrDocument{id=47, intGSF=656817280, longGSF=4504755606069887992, 
doubleGSF=16695.274917834446, floatGSF=28231.121, dateGSF=Tue Apr 27 08:38:02 
GMT 50460483, stringGSF=base_string_762373__00044251, boolGSF=false, 
sortableGSF=base_string_762408__00018553, _version_=1712067671146627079, 
_root_=47}, SolrDocument{id=48, intGSF=656817280, longGSF=4504755606069887992, 
doubleGSF=16695.274917834446, floatGSF=28231.121, dateGSF=Tue Apr 27 08:38:02 
GMT 50460483, stringGSF=base_string_762373__00044251, boolGSF=true, 
sortableGSF=base_string_762408__00018553, _version_=1712067671146627073, 
_root_=48}]}}]}}}

Stack Trace:
java.lang.AssertionError: Unexpected number of elements in the group for 
'intGSF' size: '5' GroupValue: '656787505' rsp: 
{responseHeader={zkConnected=true,status=0,QTime=7,params={q=*:*,group.sort=id 
asc,_stateVer_=dv_coll:3,group.limit=100,rows=100,wt=javabin,version=2,group.field=intGSF,group=true}},grouped={intGSF={matches=46,groups=[{groupValue=656787505,doclist={numFound=5,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=0,
 intGSF=656787505, longGSF=4504755606069861424, doubleGSF=499.2749178344455, 
floatGSF=4652.1216, dateGSF=Tue Apr 27 08:37:34 GMT 50460483, 
stringGSF=base_string_762373__00006954, boolGSF=true, 
sortableGSF=base_string_762408__00002837, _version_=1712067671144529920, 
_root_=0}, SolrDocument{id=1, intGSF=656787505, longGSF=4504755606069861424, 
doubleGSF=499.2749178344455, floatGSF=4652.1216, dateGSF=Tue Apr 27 08:37:34 
GMT 50460483, stringGSF=base_string_762373__00006954, boolGSF=false, 
sortableGSF=base_string_762408__00002837, _version_=1712067671143481344, 
_root_=1}, SolrDocument{id=2, intGSF=656787505, longGSF=4504755606069861424, 
doubleGSF=499.2749178344455, floatGSF=4652.1216, dateGSF=Tue Apr 27 08:37:34 
GMT 50460483, stringGSF=base_string_762373__00006954, boolGSF=true, 
sortableGSF=base_string_762408__00002837, _version_=1712067671146627072, 
_root_=2}, SolrDocument{id=4, intGSF=656787505, longGSF=4504755606069861424, 
doubleGSF=499.2749178344455, floatGSF=4652.1216, dateGSF=Tue Apr 27 08:37:34 
GMT 50460483, stringGSF=base_string_762373__00006954, boolGSF=true, 
sortableGSF=base_string_762408__00002837, _version_=1712067671145578496, 
_root_=4}, SolrDocument{id=5, intGSF=656787505, longGSF=4504755606069861424, 
doubleGSF=499.2749178344455, floatGSF=4652.1216, dateGSF=Tue Apr 27 08:37:34 
GMT 50460483, stringGSF=base_string_762373__00006954, boolGSF=false, 
sortableGSF=base_string_762408__00002837, _version_=1712067671142432768, 
_root_=5}]}}, 
{groupValue=656791825,doclist={numFound=5,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=10,
 intGSF=656791825, longGSF=4504755606069863831, doubleGSF=8770.274917834446, 
floatGSF=7999.1216, dateGSF=Tue Apr 27 08:37:35 GMT 50460483, 
stringGSF=base_string_762373__00010370, boolGSF=true, 
sortableGSF=base_string_762408__00004413, _version_=1712067671145578497, 
_root_=10}, SolrDocument{id=11, intGSF=656791825, longGSF=4504755606069863831, 
doubleGSF=8770.274917834446, floatGSF=7999.1216, dateGSF=Tue Apr 27 08:37:35 
GMT 50460483, stringGSF=base_string_762373__00010370, boolGSF=false, 
sortableGSF=base_string_762408__00004413, _version_=1712067671145578498, 
_root_=11}, SolrDocument{id=12, intGSF=656791825, longGSF=4504755606069863831, 
doubleGSF=8770.274917834446, floatGSF=7999.1216, dateGSF=Tue Apr 27 08:37:35 
GMT 50460483, stringGSF=base_string_762373__00010370, boolGSF=true, 
sortableGSF=base_string_762408__00004413, _version_=1712067671145578498, 
_root_=12}, SolrDocument{id=13, intGSF=656791825, longGSF=4504755606069863831, 
doubleGSF=8770.274917834446, floatGSF=7999.1216, dateGSF=Tue Apr 27 08:37:35 
GMT 50460483, stringGSF=base_string_762373__00010370, boolGSF=false, 
sortableGSF=base_string_762408__00004413, _version_=1712067671145578499, 
_root_=13}, SolrDocument{id=8, intGSF=656791825, longGSF=4504755606069863831, 
doubleGSF=8770.274917834446, floatGSF=7999.1216, dateGSF=Tue Apr 27 08:37:35 
GMT 50460483, stringGSF=base_string_762373__00010370, boolGSF=true, 
sortableGSF=base_string_762408__00004413, _version_=1712067671145578496, 
_root_=8}]}}, 
{groupValue=656800507,doclist={numFound=6,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=14,
 intGSF=656800507, longGSF=4504755606069870133, doubleGSF=9291.274917834446, 
floatGSF=10356.122, dateGSF=Tue Apr 27 08:37:42 GMT 50460483, 
stringGSF=base_string_762373__00015939, boolGSF=true, 
sortableGSF=base_string_762408__00004467, _version_=1712067671145578500, 
_root_=14}, SolrDocument{id=15, intGSF=656800507, longGSF=4504755606069870133, 
doubleGSF=9291.274917834446, floatGSF=10356.122, dateGSF=Tue Apr 27 08:37:42 
GMT 50460483, stringGSF=base_string_762373__00015939, boolGSF=false, 
sortableGSF=base_string_762408__00004467, _version_=1712067671145578499, 
_root_=15}, SolrDocument{id=16, intGSF=656800507, longGSF=4504755606069870133, 
doubleGSF=9291.274917834446, floatGSF=10356.122, dateGSF=Tue Apr 27 08:37:42 
GMT 50460483, stringGSF=base_string_762373__00015939, boolGSF=true, 
sortableGSF=base_string_762408__00004467, _version_=1712067671145578500, 
_root_=16}, SolrDocument{id=17, intGSF=656800507, longGSF=4504755606069870133, 
doubleGSF=9291.274917834446, floatGSF=10356.122, dateGSF=Tue Apr 27 08:37:42 
GMT 50460483, stringGSF=base_string_762373__00015939, boolGSF=false, 
sortableGSF=base_string_762408__00004467, _version_=1712067671142432769, 
_root_=17}, SolrDocument{id=19, intGSF=656800507, longGSF=4504755606069870133, 
doubleGSF=9291.274917834446, floatGSF=10356.122, dateGSF=Tue Apr 27 08:37:42 
GMT 50460483, stringGSF=base_string_762373__00015939, boolGSF=false, 
sortableGSF=base_string_762408__00004467, _version_=1712067671142432770, 
_root_=19}, SolrDocument{id=20, intGSF=656800507, longGSF=4504755606069870133, 
doubleGSF=9291.274917834446, floatGSF=10356.122, dateGSF=Tue Apr 27 08:37:42 
GMT 50460483, stringGSF=base_string_762373__00015939, boolGSF=true, 
sortableGSF=base_string_762408__00004467, _version_=1712067671145578501, 
_root_=20}]}}, 
{groupValue=null,doclist={numFound=6,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=10000,
 _version_=1712067671139287040, _root_=10000}, SolrDocument{id=10005, 
_version_=1712067671145578497, _root_=10005}, SolrDocument{id=10015, 
_version_=1712067671145578501, _root_=10015}, SolrDocument{id=10020, 
_version_=1712067671145578502, _root_=10020}, SolrDocument{id=10030, 
_version_=1712067671142432775, _root_=10030}, SolrDocument{id=10040, 
_version_=1712067671142432778, _root_=10040}]}}, 
{groupValue=656802647,doclist={numFound=6,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=21,
 intGSF=656802647, longGSF=4504755606069875044, doubleGSF=11407.274917834446, 
floatGSF=15912.122, dateGSF=Tue Apr 27 08:37:45 GMT 50460483, 
stringGSF=base_string_762373__00021949, boolGSF=false, 
sortableGSF=base_string_762408__00009604, _version_=1712067671142432771, 
_root_=21}, SolrDocument{id=22, intGSF=656802647, longGSF=4504755606069875044, 
doubleGSF=11407.274917834446, floatGSF=15912.122, dateGSF=Tue Apr 27 08:37:45 
GMT 50460483, stringGSF=base_string_762373__00021949, boolGSF=true, 
sortableGSF=base_string_762408__00009604, _version_=1712067671145578502, 
_root_=22}, SolrDocument{id=23, intGSF=656802647, longGSF=4504755606069875044, 
doubleGSF=11407.274917834446, floatGSF=15912.122, dateGSF=Tue Apr 27 08:37:45 
GMT 50460483, stringGSF=base_string_762373__00021949, boolGSF=false, 
sortableGSF=base_string_762408__00009604, _version_=1712067671142432772, 
_root_=23}, SolrDocument{id=24, intGSF=656802647, longGSF=4504755606069875044, 
doubleGSF=11407.274917834446, floatGSF=15912.122, dateGSF=Tue Apr 27 08:37:45 
GMT 50460483, stringGSF=base_string_762373__00021949, boolGSF=true, 
sortableGSF=base_string_762408__00009604, _version_=1712067671145578503, 
_root_=24}, SolrDocument{id=25, intGSF=656802647, longGSF=4504755606069875044, 
doubleGSF=11407.274917834446, floatGSF=15912.122, dateGSF=Tue Apr 27 08:37:45 
GMT 50460483, stringGSF=base_string_762373__00021949, boolGSF=false, 
sortableGSF=base_string_762408__00009604, _version_=1712067671142432773, 
_root_=25}, SolrDocument{id=27, intGSF=656802647, longGSF=4504755606069875044, 
doubleGSF=11407.274917834446, floatGSF=15912.122, dateGSF=Tue Apr 27 08:37:45 
GMT 50460483, stringGSF=base_string_762373__00021949, boolGSF=false, 
sortableGSF=base_string_762408__00009604, _version_=1712067671145578504, 
_root_=27}]}}, 
{groupValue=656810943,doclist={numFound=5,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=28,
 intGSF=656810943, longGSF=4504755606069881261, doubleGSF=15027.274917834446, 
floatGSF=21214.121, dateGSF=Tue Apr 27 08:37:47 GMT 50460483, 
stringGSF=base_string_762373__00031351, boolGSF=true, 
sortableGSF=base_string_762408__00010467, _version_=1712067671145578505, 
_root_=28}, SolrDocument{id=29, intGSF=656810943, longGSF=4504755606069881261, 
doubleGSF=15027.274917834446, floatGSF=21214.121, dateGSF=Tue Apr 27 08:37:47 
GMT 50460483, stringGSF=base_string_762373__00031351, boolGSF=false, 
sortableGSF=base_string_762408__00010467, _version_=1712067671142432774, 
_root_=29}, SolrDocument{id=32, intGSF=656810943, longGSF=4504755606069881261, 
doubleGSF=15027.274917834446, floatGSF=21214.121, dateGSF=Tue Apr 27 08:37:47 
GMT 50460483, stringGSF=base_string_762373__00031351, boolGSF=true, 
sortableGSF=base_string_762408__00010467, _version_=1712067671145578506, 
_root_=32}, SolrDocument{id=33, intGSF=656810943, longGSF=4504755606069881261, 
doubleGSF=15027.274917834446, floatGSF=21214.121, dateGSF=Tue Apr 27 08:37:47 
GMT 50460483, stringGSF=base_string_762373__00031351, boolGSF=false, 
sortableGSF=base_string_762408__00010467, _version_=1712067671142432776, 
_root_=33}, SolrDocument{id=34, intGSF=656810943, longGSF=4504755606069881261, 
doubleGSF=15027.274917834446, floatGSF=21214.121, dateGSF=Tue Apr 27 08:37:47 
GMT 50460483, stringGSF=base_string_762373__00031351, boolGSF=true, 
sortableGSF=base_string_762408__00010467, _version_=1712067671146627072, 
_root_=34}]}}, 
{groupValue=656814052,doclist={numFound=6,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=35,
 intGSF=656814052, longGSF=4504755606069883827, doubleGSF=15587.274917834446, 
floatGSF=22017.121, dateGSF=Tue Apr 27 08:37:55 GMT 50460483, 
stringGSF=base_string_762373__00034599, boolGSF=false, 
sortableGSF=base_string_762408__00016833, _version_=1712067671146627073, 
_root_=35}, SolrDocument{id=36, intGSF=656814052, longGSF=4504755606069883827, 
doubleGSF=15587.274917834446, floatGSF=22017.121, dateGSF=Tue Apr 27 08:37:55 
GMT 50460483, stringGSF=base_string_762373__00034599, boolGSF=true, 
sortableGSF=base_string_762408__00016833, _version_=1712067671146627074, 
_root_=36}, SolrDocument{id=37, intGSF=656814052, longGSF=4504755606069883827, 
doubleGSF=15587.274917834446, floatGSF=22017.121, dateGSF=Tue Apr 27 08:37:55 
GMT 50460483, stringGSF=base_string_762373__00034599, boolGSF=false, 
sortableGSF=base_string_762408__00016833, _version_=1712067671142432777, 
_root_=37}, SolrDocument{id=38, intGSF=656814052, longGSF=4504755606069883827, 
doubleGSF=15587.274917834446, floatGSF=22017.121, dateGSF=Tue Apr 27 08:37:55 
GMT 50460483, stringGSF=base_string_762373__00034599, boolGSF=true, 
sortableGSF=base_string_762408__00016833, _version_=1712067671145578507, 
_root_=38}, SolrDocument{id=40, intGSF=656814052, longGSF=4504755606069883827, 
doubleGSF=15587.274917834446, floatGSF=22017.121, dateGSF=Tue Apr 27 08:37:55 
GMT 50460483, stringGSF=base_string_762373__00034599, boolGSF=true, 
sortableGSF=base_string_762408__00016833, _version_=1712067671145578508, 
_root_=40}, SolrDocument{id=41, intGSF=656814052, longGSF=4504755606069883827, 
doubleGSF=15587.274917834446, floatGSF=22017.121, dateGSF=Tue Apr 27 08:37:55 
GMT 50460483, stringGSF=base_string_762373__00034599, boolGSF=false, 
sortableGSF=base_string_762408__00016833, _version_=1712067671146627075, 
_root_=41}]}}, 
{groupValue=656817280,doclist={numFound=7,numFoundExact=true,start=0,maxScore=1.0,docs=[SolrDocument{id=42,
 intGSF=656817280, longGSF=4504755606069887992, doubleGSF=16695.274917834446, 
floatGSF=28231.121, dateGSF=Tue Apr 27 08:38:02 GMT 50460483, 
stringGSF=base_string_762373__00044251, boolGSF=true, 
sortableGSF=base_string_762408__00018553, _version_=1712067671146627072, 
_root_=42}, SolrDocument{id=43, intGSF=656817280, longGSF=4504755606069887992, 
doubleGSF=16695.274917834446, floatGSF=28231.121, dateGSF=Tue Apr 27 08:38:02 
GMT 50460483, stringGSF=base_string_762373__00044251, boolGSF=false, 
sortableGSF=base_string_762408__00018553, _version_=1712067671146627076, 
_root_=43}, SolrDocument{id=44, intGSF=656817280, longGSF=4504755606069887992, 
doubleGSF=16695.274917834446, floatGSF=28231.121, dateGSF=Tue Apr 27 08:38:02 
GMT 50460483, stringGSF=base_string_762373__00044251, boolGSF=true, 
sortableGSF=base_string_762408__00018553, _version_=1712067671146627077, 
_root_=44}, SolrDocument{id=45, intGSF=656817280, longGSF=4504755606069887992, 
doubleGSF=16695.274917834446, floatGSF=28231.121, dateGSF=Tue Apr 27 08:38:02 
GMT 50460483, stringGSF=base_string_762373__00044251, boolGSF=false, 
sortableGSF=base_string_762408__00018553, _version_=1712067671143481344, 
_root_=45}, SolrDocument{id=46, intGSF=656817280, longGSF=4504755606069887992, 
doubleGSF=16695.274917834446, floatGSF=28231.121, dateGSF=Tue Apr 27 08:38:02 
GMT 50460483, stringGSF=base_string_762373__00044251, boolGSF=true, 
sortableGSF=base_string_762408__00018553, _version_=1712067671146627078, 
_root_=46}, SolrDocument{id=47, intGSF=656817280, longGSF=4504755606069887992, 
doubleGSF=16695.274917834446, floatGSF=28231.121, dateGSF=Tue Apr 27 08:38:02 
GMT 50460483, stringGSF=base_string_762373__00044251, boolGSF=false, 
sortableGSF=base_string_762408__00018553, _version_=1712067671146627079, 
_root_=47}, SolrDocument{id=48, intGSF=656817280, longGSF=4504755606069887992, 
doubleGSF=16695.274917834446, floatGSF=28231.121, dateGSF=Tue Apr 27 08:38:02 
GMT 50460483, stringGSF=base_string_762373__00044251, boolGSF=true, 
sortableGSF=base_string_762408__00018553, _version_=1712067671146627073, 
_root_=48}]}}]}}}
        at 
__randomizedtesting.SeedInfo.seed([1BAAB04FD3B0FCD8:11231723836D3B51]:0)
        at org.junit.Assert.fail(Assert.java:89)
        at 
org.apache.solr.cloud.DocValuesNotIndexedTest.doGroupingDvOnly(DocValuesNotIndexedTest.java:404)
        at 
org.apache.solr.cloud.DocValuesNotIndexedTest.testGroupingDVOnlySortFirst(DocValuesNotIndexedTest.java:327)
        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 14668 lines...]
   [junit4] Suite: org.apache.solr.cloud.DocValuesNotIndexedTest
   [junit4]   2> 1765562 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-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-NightlyTests-8.x/checkout/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 1765562 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1765562 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_1BAAB04FD3B0FCD8-001/data-dir-154-001
   [junit4]   2> 1765562 WARN  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=102 numCloses=102
   [junit4]   2> 1765562 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 1765564 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-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> 1765564 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.c.SolrCloudTestCase Using per-replica state
   [junit4]   2> 1765564 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_1BAAB04FD3B0FCD8-001/tempDir-001
   [junit4]   2> 1765565 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1765565 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
   [junit4]   2> 1765565 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 1765566 WARN  (ZkTestServer Run Thread) [     ] 
o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
   [junit4]   2> 1765665 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.c.ZkTestServer start zk server on port: 33561
   [junit4]   2> 1765665 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:33561
   [junit4]   2> 1765665 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:33561
   [junit4]   2> 1765665 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 33561
   [junit4]   2> 1765666 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1765668 INFO  (zkConnectionManagerCallback-17003-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1765668 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1765671 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1765672 INFO  (zkConnectionManagerCallback-17005-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1765672 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1765672 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1765673 INFO  (zkConnectionManagerCallback-17007-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1765673 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1765775 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1765775 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1765775 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 1765775 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 1765775 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 
98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
   [junit4]   2> 1765775 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 
98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
   [junit4]   2> 1765776 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1765776 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1765776 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1765776 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1765776 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1765776 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1765777 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2d3641ad{/solr,null,AVAILABLE}
   [junit4]   2> 1765777 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@33520102{/solr,null,AVAILABLE}
   [junit4]   2> 1765777 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@3c9f3422{HTTP/1.1, (http/1.1, 
h2c)}{127.0.0.1:46053}
   [junit4]   2> 1765777 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.e.j.s.Server Started @1765810ms
   [junit4]   2> 1765777 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
zkHost=127.0.0.1:33561/solr, hostPort=46053}
   [junit4]   2> 1765777 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@3328cdb1{HTTP/1.1, (http/1.1, 
h2c)}{127.0.0.1:45669}
   [junit4]   2> 1765777 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.e.j.s.Server Started @1765810ms
   [junit4]   2> 1765777 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
zkHost=127.0.0.1:33561/solr, hostPort=45669}
   [junit4]   2> 1765777 ERROR (jetty-launcher-17008-thread-2) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1765777 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1765777 ERROR (jetty-launcher-17008-thread-1) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1765777 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1765777 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.11.0
   [junit4]   2> 1765777 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1765777 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.11.0
   [junit4]   2> 1765777 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr
   [junit4]   2> 1765777 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1765777 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2021-09-27T15:02:43.973Z
   [junit4]   2> 1765777 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr
   [junit4]   2> 1765777 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2021-09-27T15:02:43.973Z
   [junit4]   2> 1765778 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1765779 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1765779 INFO  (zkConnectionManagerCallback-17010-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1765779 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1765779 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1765779 INFO  (zkConnectionManagerCallback-17012-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1765779 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1765780 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1765783 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.a.s.c.SolrXmlConfig Metrics collection is disabled.
   [junit4]   2> 1765783 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.a.s.c.SolrXmlConfig Metrics collection is disabled.
   [junit4]   2> 1765784 WARN  
(jetty-launcher-17008-thread-2-SendThread(127.0.0.1:33561)) [     ] 
o.a.z.ClientCnxn An exception was thrown while closing send thread for session 
0x101814df1440003.
   [junit4]   2>           => EndOfStreamException: Unable to read additional 
data from server sessionid 0x101814df1440003, 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 0x101814df1440003, 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> 1766531 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1766538 WARN  (jetty-launcher-17008-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@3e57838c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1766538 WARN  (jetty-launcher-17008-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@3e57838c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1766567 WARN  (jetty-launcher-17008-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@4500584c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1766567 WARN  (jetty-launcher-17008-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@4500584c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1766568 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33561/solr
   [junit4]   2> 1766590 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1766604 INFO  (zkConnectionManagerCallback-17026-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1766604 INFO  (jetty-launcher-17008-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1766706 INFO  (jetty-launcher-17008-thread-1) 
[n:127.0.0.1:45669_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 1766706 INFO  (zkConnectionManagerCallback-17028-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1766706 INFO  (jetty-launcher-17008-thread-1) 
[n:127.0.0.1:45669_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 1766772 WARN  (jetty-launcher-17008-thread-1) 
[n:127.0.0.1:45669_solr     ] o.a.s.c.ZkController Contents of zookeeper 
/security.json are world-readable; consider setting up ACLs as described in 
https://solr.apache.org/guide/zookeeper-access-control.html
   [junit4]   2> 1766775 INFO  (jetty-launcher-17008-thread-1) 
[n:127.0.0.1:45669_solr     ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:45669_solr
   [junit4]   2> 1766776 INFO  (jetty-launcher-17008-thread-1) 
[n:127.0.0.1:45669_solr     ] o.a.s.c.Overseer Overseer 
(id=72481240774868998-127.0.0.1:45669_solr-n_0000000000) starting
   [junit4]   2> 1766785 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1766785 INFO  (jetty-launcher-17008-thread-1) 
[n:127.0.0.1:45669_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:45669_solr
   [junit4]   2> 1766786 INFO  
(OverseerStateUpdate-72481240774868998-127.0.0.1:45669_solr-n_0000000000) 
[n:127.0.0.1:45669_solr     ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:45669_solr
   [junit4]   2> 1766787 INFO  
(OverseerStateUpdate-72481240774868998-127.0.0.1:45669_solr-n_0000000000) 
[n:127.0.0.1:45669_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1766788 INFO  (jetty-launcher-17008-thread-1) 
[n:127.0.0.1:45669_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 1766788 WARN  (jetty-launcher-17008-thread-1) 
[n:127.0.0.1:45669_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> 1766789 WARN  (jetty-launcher-17008-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@4514969e[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1766789 WARN  (jetty-launcher-17008-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@4514969e[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1766808 WARN  (jetty-launcher-17008-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@4390df84[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1766808 WARN  (jetty-launcher-17008-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@4390df84[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1766809 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33561/solr
   [junit4]   2> 1766811 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1766813 INFO  (zkConnectionManagerCallback-17043-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1766813 INFO  (jetty-launcher-17008-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1766815 WARN  
(jetty-launcher-17008-thread-2-SendThread(127.0.0.1:33561)) [     ] 
o.a.z.ClientCnxn An exception was thrown while closing send thread for session 
0x101814df1440007.
   [junit4]   2>           => EndOfStreamException: Unable to read additional 
data from server sessionid 0x101814df1440007, 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 0x101814df1440007, 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> 1766826 INFO  (jetty-launcher-17008-thread-1) 
[n:127.0.0.1:45669_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_1BAAB04FD3B0FCD8-001/tempDir-001/node1
   [junit4]   2> 1766916 INFO  (jetty-launcher-17008-thread-2) 
[n:127.0.0.1:46053_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 1766919 INFO  (zkConnectionManagerCallback-17048-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1766919 INFO  (jetty-launcher-17008-thread-2) 
[n:127.0.0.1:46053_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 1766921 WARN  (jetty-launcher-17008-thread-2) 
[n:127.0.0.1:46053_solr     ] o.a.s.c.ZkController Contents of zookeeper 
/security.json are world-readable; consider setting up ACLs as described in 
https://solr.apache.org/guide/zookeeper-access-control.html
   [junit4]   2> 1766922 INFO  (jetty-launcher-17008-thread-2) 
[n:127.0.0.1:46053_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1766925 INFO  (jetty-launcher-17008-thread-2) 
[n:127.0.0.1:46053_solr     ] o.a.s.c.ZkController Publish 
node=127.0.0.1:46053_solr as DOWN
   [junit4]   2> 1766926 INFO  (jetty-launcher-17008-thread-2) 
[n:127.0.0.1:46053_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient core cache for max 2147483647 cores with initial capacity of 1024
   [junit4]   2> 1766926 INFO  (jetty-launcher-17008-thread-2) 
[n:127.0.0.1:46053_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:46053_solr
   [junit4]   2> 1766927 INFO  (zkCallback-17027-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1766927 INFO  (zkCallback-17047-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1766928 INFO  (jetty-launcher-17008-thread-2) 
[n:127.0.0.1:46053_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 1766928 WARN  (jetty-launcher-17008-thread-2) 
[n:127.0.0.1:46053_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> 1766948 INFO  (jetty-launcher-17008-thread-2) 
[n:127.0.0.1:46053_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_1BAAB04FD3B0FCD8-001/tempDir-001/node2
   [junit4]   2> 1766956 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
   [junit4]   2> 1766956 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1766959 INFO  (zkConnectionManagerCallback-17059-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1766959 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1766960 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 1766961 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33561/solr ready
   [junit4]   2> 1766971 INFO  
(OverseerThreadFactory-17038-thread-1-processing-n:127.0.0.1:45669_solr) 
[n:127.0.0.1:45669_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
dv_coll
   [junit4]   2> 1767076 INFO  
(OverseerStateUpdate-72481240774868998-127.0.0.1:45669_solr-n_0000000000) 
[n:127.0.0.1:45669_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"dv_coll_shard1_replica_n1",
   [junit4]   2>   "node_name":"127.0.0.1:46053_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:46053/solr";,
   [junit4]   2>   "collection":"dv_coll",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1767078 INFO  
(OverseerStateUpdate-72481240774868998-127.0.0.1:45669_solr-n_0000000000) 
[n:127.0.0.1:45669_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"dv_coll_shard2_replica_n2",
   [junit4]   2>   "node_name":"127.0.0.1:45669_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:45669/solr";,
   [junit4]   2>   "collection":"dv_coll",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1767080 INFO  
(OverseerStateUpdate-72481240774868998-127.0.0.1:45669_solr-n_0000000000) 
[n:127.0.0.1:45669_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"dv_coll_shard3_replica_n4",
   [junit4]   2>   "node_name":"127.0.0.1:46053_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:46053/solr";,
   [junit4]   2>   "collection":"dv_coll",
   [junit4]   2>   "shard":"shard3",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1767082 INFO  
(OverseerStateUpdate-72481240774868998-127.0.0.1:45669_solr-n_0000000000) 
[n:127.0.0.1:45669_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"dv_coll_shard4_replica_n6",
   [junit4]   2>   "node_name":"127.0.0.1:45669_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:45669/solr";,
   [junit4]   2>   "collection":"dv_coll",
   [junit4]   2>   "shard":"shard4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1767284 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr    
x:dv_coll_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf1&newCollection=true&name=dv_coll_shard1_replica_n1&action=CREATE&numShards=4&collection=dv_coll&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1767284 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr    
x:dv_coll_shard2_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf1&newCollection=true&name=dv_coll_shard2_replica_n2&action=CREATE&numShards=4&collection=dv_coll&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1767284 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr    
x:dv_coll_shard2_replica_n2 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient core cache for max 2147483647 cores with initial capacity of 1024
   [junit4]   2> 1767285 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr    
x:dv_coll_shard3_replica_n4 ] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf1&newCollection=true&name=dv_coll_shard3_replica_n4&action=CREATE&numShards=4&collection=dv_coll&shard=shard3&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1767286 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr    
x:dv_coll_shard4_replica_n6 ] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf1&newCollection=true&name=dv_coll_shard4_replica_n6&action=CREATE&numShards=4&collection=dv_coll&shard=shard4&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1767295 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 1767297 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] 
o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 1767297 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1767297 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] 
o.a.s.c.CoreContainer Creating SolrCore 'dv_coll_shard4_replica_n6' using 
configuration from configset conf1, trusted=true
   [junit4]   2> 1767298 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.c.SolrCore 
[[dv_coll_shard4_replica_n6] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_1BAAB04FD3B0FCD8-001/tempDir-001/node1/dv_coll_shard4_replica_n6],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_1BAAB04FD3B0FCD8-001/tempDir-001/node1/dv_coll_shard4_replica_n6/data/]
   [junit4]   2> 1767302 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 1767302 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 1767302 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] 
o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 1767303 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1767303 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] 
o.a.s.c.CoreContainer Creating SolrCore 'dv_coll_shard2_replica_n2' using 
configuration from configset conf1, trusted=true
   [junit4]   2> 1767303 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] 
o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 1767303 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.c.SolrCore 
[[dv_coll_shard2_replica_n2] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_1BAAB04FD3B0FCD8-001/tempDir-001/node1/dv_coll_shard2_replica_n2],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_1BAAB04FD3B0FCD8-001/tempDir-001/node1/dv_coll_shard2_replica_n2/data/]
   [junit4]   2> 1767304 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1767304 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] 
o.a.s.c.CoreContainer Creating SolrCore 'dv_coll_shard3_replica_n4' using 
configuration from configset conf1, trusted=true
   [junit4]   2> 1767304 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.c.SolrCore 
[[dv_coll_shard3_replica_n4] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_1BAAB04FD3B0FCD8-001/tempDir-001/node2/dv_coll_shard3_replica_n4],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_1BAAB04FD3B0FCD8-001/tempDir-001/node2/dv_coll_shard3_replica_n4/data/]
   [junit4]   2> 1767307 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 1767307 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] 
o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 1767308 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1767308 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] 
o.a.s.c.CoreContainer Creating SolrCore 'dv_coll_shard1_replica_n1' using 
configuration from configset conf1, trusted=true
   [junit4]   2> 1767308 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.c.SolrCore 
[[dv_coll_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_1BAAB04FD3B0FCD8-001/tempDir-001/node2/dv_coll_shard1_replica_n1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_1BAAB04FD3B0FCD8-001/tempDir-001/node2/dv_coll_shard1_replica_n1/data/]
   [junit4]   2> 1767342 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1767342 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1767343 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1767343 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1767343 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1767343 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1767344 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1767344 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1767346 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1767346 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1767346 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1767346 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1767346 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1767346 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/conf1/managed-schema
   [junit4]   2> 1767346 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1767346 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/conf1/managed-schema
   [junit4]   2> 1767346 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1767347 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1767347 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 1767347 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1767347 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1712067670749216768
   [junit4]   2> 1767347 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1767347 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1767348 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1767348 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1767348 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 1767348 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1767348 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1712067670750265344
   [junit4]   2> 1767349 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1767349 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1767349 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/conf1/managed-schema
   [junit4]   2> 1767350 INFO  
(searcherExecutor-17063-thread-1-processing-n:127.0.0.1:45669_solr 
x:dv_coll_shard2_replica_n2 c:dv_coll s:shard2 r:core_node5) 
[n:127.0.0.1:45669_solr c:dv_coll s:shard2 r:core_node5 
x:dv_coll_shard2_replica_n2 ] o.a.s.c.SolrCore [dv_coll_shard2_replica_n2]  
Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1767350 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 1767350 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1767350 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1712067670752362496
   [junit4]   2> 1767350 INFO  
(searcherExecutor-17065-thread-1-processing-n:127.0.0.1:46053_solr 
x:dv_coll_shard3_replica_n4 c:dv_coll s:shard3 r:core_node7) 
[n:127.0.0.1:46053_solr c:dv_coll s:shard3 r:core_node7 
x:dv_coll_shard3_replica_n4 ] o.a.s.c.SolrCore [dv_coll_shard3_replica_n4]  
Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1767352 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1767352 INFO  
(searcherExecutor-17061-thread-1-processing-n:127.0.0.1:45669_solr 
x:dv_coll_shard4_replica_n6 c:dv_coll s:shard4 r:core_node8) 
[n:127.0.0.1:45669_solr c:dv_coll s:shard4 r:core_node8 
x:dv_coll_shard4_replica_n6 ] o.a.s.c.SolrCore [dv_coll_shard4_replica_n6]  
Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1767353 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1767353 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/conf1/managed-schema
   [junit4]   2> 1767354 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 1767354 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1767354 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1712067670756556800
   [junit4]   2> 1767357 INFO  
(searcherExecutor-17067-thread-1-processing-n:127.0.0.1:46053_solr 
x:dv_coll_shard1_replica_n1 c:dv_coll s:shard1 r:core_node3) 
[n:127.0.0.1:46053_solr c:dv_coll s:shard1 r:core_node3 
x:dv_coll_shard1_replica_n1 ] o.a.s.c.SolrCore [dv_coll_shard1_replica_n1]  
Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1767359 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/dv_coll/terms/shard3 to Terms{values={core_node7=0}, version=0}
   [junit4]   2> 1767359 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/dv_coll/leaders/shard3
   [junit4]   2> 1767361 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/dv_coll/terms/shard2 to Terms{values={core_node5=0}, version=0}
   [junit4]   2> 1767361 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/dv_coll/leaders/shard2
   [junit4]   2> 1767363 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/dv_coll/terms/shard1 to Terms{values={core_node3=0}, version=0}
   [junit4]   2> 1767363 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/dv_coll/leaders/shard1
   [junit4]   2> 1767365 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1767365 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1767365 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:46053/solr/dv_coll_shard3_replica_n4/
   [junit4]   2> 1767365 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1767366 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/dv_coll/terms/shard4 to Terms{values={core_node8=0}, version=0}
   [junit4]   2> 1767366 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/dv_coll/leaders/shard4
   [junit4]   2> 1767366 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] 
o.a.s.c.SyncStrategy http://127.0.0.1:46053/solr/dv_coll_shard3_replica_n4/ has 
no replicas
   [junit4]   2> 1767366 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/dv_coll/leaders/shard3/leader after winning as 
/collections/dv_coll/leader_elect/shard3/election/72481240774869000-core_node7-n_0000000000
   [junit4]   2> 1767369 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1767369 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1767369 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:45669/solr/dv_coll_shard2_replica_n2/
   [junit4]   2> 1767370 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1767371 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] 
o.a.s.c.SyncStrategy http://127.0.0.1:45669/solr/dv_coll_shard2_replica_n2/ has 
no replicas
   [junit4]   2> 1767371 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/dv_coll/leaders/shard2/leader after winning as 
/collections/dv_coll/leader_elect/shard2/election/72481240774868998-core_node5-n_0000000000
   [junit4]   2> 1767372 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:46053/solr/dv_coll_shard3_replica_n4/ shard3
   [junit4]   2> 1767372 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1767372 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1767372 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:46053/solr/dv_coll_shard1_replica_n1/
   [junit4]   2> 1767373 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1767373 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] 
o.a.s.c.SyncStrategy http://127.0.0.1:46053/solr/dv_coll_shard1_replica_n1/ has 
no replicas
   [junit4]   2> 1767373 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/dv_coll/leaders/shard1/leader after winning as 
/collections/dv_coll/leader_elect/shard1/election/72481240774869000-core_node3-n_0000000000
   [junit4]   2> 1767373 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1767373 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1767373 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:45669/solr/dv_coll_shard4_replica_n6/
   [junit4]   2> 1767374 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:46053/solr/dv_coll_shard1_replica_n1/ shard1
   [junit4]   2> 1767375 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1767375 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:45669/solr/dv_coll_shard2_replica_n2/ shard2
   [junit4]   2> 1767375 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] 
o.a.s.c.SyncStrategy http://127.0.0.1:45669/solr/dv_coll_shard4_replica_n6/ has 
no replicas
   [junit4]   2> 1767375 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/dv_coll/leaders/shard4/leader after winning as 
/collections/dv_coll/leader_elect/shard4/election/72481240774868998-core_node8-n_0000000000
   [junit4]   2> 1767377 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:45669/solr/dv_coll_shard4_replica_n6/ shard4
   [junit4]   2> 1767478 INFO  (zkCallback-17027-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] 
for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1767478 INFO  (zkCallback-17047-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] 
for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1767478 INFO  (zkCallback-17027-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] 
for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1767479 INFO  (zkCallback-17027-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] 
for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1767479 INFO  (zkCallback-17047-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] 
for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1767479 INFO  (zkCallback-17027-thread-4) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] 
for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1767479 INFO  (zkCallback-17047-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] 
for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1767479 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard2 r:core_node5 x:dv_coll_shard2_replica_n2 ] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1767480 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1 ] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1767481 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr 
c:dv_coll s:shard3 r:core_node7 x:dv_coll_shard3_replica_n4 ] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1767481 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n6 ] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1767484 INFO  (qtp1039082620-30938) [n:127.0.0.1:45669_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf1&newCollection=true&name=dv_coll_shard4_replica_n6&action=CREATE&numShards=4&collection=dv_coll&shard=shard4&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=198
   [junit4]   2> 1767485 INFO  (qtp1039082620-30946) [n:127.0.0.1:45669_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf1&newCollection=true&name=dv_coll_shard2_replica_n2&action=CREATE&numShards=4&collection=dv_coll&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=201
   [junit4]   2> 1767485 INFO  (qtp844680217-30940) [n:127.0.0.1:46053_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf1&newCollection=true&name=dv_coll_shard1_replica_n1&action=CREATE&numShards=4&collection=dv_coll&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=201
   [junit4]   2> 1767486 INFO  (qtp844680217-30944) [n:127.0.0.1:46053_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf1&newCollection=true&name=dv_coll_shard3_replica_n4&action=CREATE&numShards=4&collection=dv_coll&shard=shard3&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=201
   [junit4]   2> 1767488 INFO  (qtp1039082620-30941) [n:127.0.0.1:45669_solr    
 ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at 
most 45 seconds. Check all shard replicas
   [junit4]   2> 1767586 INFO  (zkCallback-17027-thread-4) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] 
for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1767586 INFO  (zkCallback-17027-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] 
for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1767586 INFO  (zkCallback-17047-thread-4) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] 
for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1767586 INFO  (zkCallback-17027-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] 
for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1767586 INFO  (zkCallback-17027-thread-5) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] 
for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1767586 INFO  (zkCallback-17047-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] 
for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1767586 INFO  (zkCallback-17027-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] 
for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1767586 INFO  (zkCallback-17047-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json] 
for collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1767586 INFO  (zkCallback

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

000000) closing
   [junit4]   2> 1768298 INFO  
(OverseerStateUpdate-72481240774868998-127.0.0.1:45669_solr-n_0000000000) 
[n:127.0.0.1:45669_solr     ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:45669_solr
   [junit4]   2> 1768299 INFO  
(OverseerAutoScalingTriggerThread-72481240774868998-127.0.0.1:45669_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 1768301 INFO  (jetty-closer-17098-thread-2) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node 
tag=null
   [junit4]   2> 1768301 INFO  (jetty-closer-17098-thread-2) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm 
tag=null
   [junit4]   2> 1768301 INFO  (jetty-closer-17098-thread-2) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty 
tag=null
   [junit4]   2> 1768302 INFO  (closeThreadPool-17108-thread-1) [     ] 
o.a.s.c.Overseer Overseer 
(id=72481240774868998-127.0.0.1:45669_solr-n_0000000000) closing
   [junit4]   2> 1768302 INFO  (jetty-closer-17098-thread-2) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster 
tag=null
   [junit4]   2> 1768302 WARN  
(jetty-launcher-17008-thread-1-SendThread(127.0.0.1:33561)) [     ] 
o.a.z.ClientCnxn An exception was thrown while closing send thread for session 
0x101814df1440006.
   [junit4]   2>           => EndOfStreamException: Unable to read additional 
data from server sessionid 0x101814df1440006, 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 0x101814df1440006, 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> 1768303 INFO  (zkCallback-17047-thread-3) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 1768403 INFO  (jetty-closer-17098-thread-1) [     ] 
o.a.s.c.Overseer Overseer 
(id=72481240774868998-127.0.0.1:45669_solr-n_0000000000) closing
   [junit4]   2> 1768404 INFO  (jetty-closer-17098-thread-1) [     ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@3328cdb1{HTTP/1.1, (http/1.1, 
h2c)}{127.0.0.1:0}
   [junit4]   2> 1768404 INFO  (jetty-closer-17098-thread-1) [     ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@33520102{/solr,null,STOPPED}
   [junit4]   2> 1768404 INFO  (jetty-closer-17098-thread-1) [     ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1768503 INFO  (jetty-closer-17098-thread-2) [     ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@3c9f3422{HTTP/1.1, (http/1.1, 
h2c)}{127.0.0.1:0}
   [junit4]   2> 1768504 INFO  (jetty-closer-17098-thread-2) [     ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@2d3641ad{/solr,null,STOPPED}
   [junit4]   2> 1768504 INFO  (jetty-closer-17098-thread-2) [     ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1768504 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.c.ZkTestServer Shutting down ZkTestServer.
   [junit4]   2> 1768707 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>        6       /solr/configs/conf1/managed-schema
   [junit4]   2>        4       /solr/configs/conf1
   [junit4]   2>        3       /solr/clusterprops.json
   [junit4]   2>        3       /solr/aliases.json
   [junit4]   2>        3       /solr/collections/dv_coll/terms/shard3
   [junit4]   2>        3       /solr/collections/dv_coll/terms/shard2
   [junit4]   2>        3       /solr/collections/dv_coll/terms/shard1
   [junit4]   2>        3       /solr/collections/dv_coll/terms/shard4
   [junit4]   2>        2       /solr/packages.json
   [junit4]   2>        2       /solr/security.json
   [junit4]   2>        2       /solr/collections/dv_coll/collectionprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        27      /solr/collections/dv_coll/state.json
   [junit4]   2>        4       /solr/configs/conf1/managed-schema
   [junit4]   2>        3       /solr/clusterstate.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        23      /solr/overseer/queue
   [junit4]   2>        11      /solr/collections/dv_coll/state.json
   [junit4]   2>        7       /solr/live_nodes
   [junit4]   2>        6       /solr/collections
   [junit4]   2>        5       /solr/overseer/collection-queue-work
   [junit4]   2> 
   [junit4]   2> 1768709 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:33561
   [junit4]   2> 1768709 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:33561
   [junit4]   2> 1768709 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[1BAAB04FD3B0FCD8]-worker) [     ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 33561
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_1BAAB04FD3B0FCD8-001
   [junit4]   2> Sep 27, 2021 3:02:47 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), 
sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=sk-SK, 
timezone=Greenwich
   [junit4]   2> NOTE: Linux 4.15.0-147-generic amd64/Oracle Corporation 
1.8.0_291 (64-bit)/cpus=4,threads=1,free=218052888,total=517996544
   [junit4]   2> NOTE: All tests run in this JVM: [SystemInfoHandlerTest, 
DistributedExpandComponentTest, TestSQLHandler, TestSimScenario, 
TestFieldCacheReopen, TestUninvertingReader, NodeAddedTriggerIntegrationTest, 
TestJsonRequest, PreAnalyzedUpdateProcessorTest, RouteFieldTest, 
MetricsHistoryHandlerTest, UniqFieldsUpdateProcessorFactoryTest, 
TestSchemalessBufferedUpdates, IgnoreLargeDocumentProcessorFactoryTest, 
TestCloudDeduplication, TestCopyFieldCollectionResource, 
BigEndianAscendingWordSerializerTest, TriggerSetPropertiesIntegrationTest, 
MultiThreadedOCPTest, DirectSolrConnectionTest, SliceStateTest, 
RegexBytesRefFilterTest, CollectionStateFormat2Test, TestCircuitBreaker, 
ConcurrentCreateCollectionTest, TestRuleBasedAuthorizationWithKerberos, 
TestConfigSetImmutable, CustomHighlightComponentTest, 
ConfigureRecoveryStrategyTest, TestReplicationHandlerBackup, 
TestPKIAuthenticationPlugin, ClusterStateMockUtilTest, SecurityHeadersTest, 
TestReRankQParserPlugin, CircularListTest, MaxScoreCollectorTest, 
RankQParserPluginTest, TestObjectReleaseTracker, SearchHandlerTest, 
HighlighterTest, JsonLoaderTest, TestLRUCache, MetricUtilsTest, 
SpellPossibilityIteratorTest, TestFunctionQuery, BlockCacheTest, 
TestRetrieveFieldsOptimizer, TestMinimalConfig, TestSSLRandomization, 
PreAnalyzedFieldManagedSchemaCloudTest, JWTAuthPluginTest, TestContainerPlugin, 
TestHighlightDedupGrouping, TestNonDefinedSimilarityFactory, 
CreateCollectionCleanupTest, ResponseBuilderTest, TestSolrConfigHandlerCloud, 
TestLuceneMatchVersion, TestWaitForStateWithJettyShutdowns, SplitShardTest, 
AutoAddReplicasIntegrationTest, OverseerSolrResponseTest, TestRandomFlRTGCloud, 
TestElisionMultitermQuery, HdfsRestartWhileUpdatingTest, TestFilteredDocIdSet, 
SignatureUpdateProcessorFactoryTest, TestDistribDocBasedVersion, 
CoreAdminHandlerTest, DistribCursorPagingTest, TestStressRecovery, 
BasicAuthIntegrationTest, RequiredFieldsTest, TestXIncludeConfig, 
TestSkipOverseerOperations, XmlInterpolationTest, ExternalFileFieldSortTest, 
TestJettySolrRunner, ShardRoutingCustomTest, 
TimeRoutedAliasUpdateProcessorTest, IndexSizeTriggerSizeEstimationTest, 
DynamicMapsTest, SpatialRPTFieldTypeTest, 
DistributedFacetPivotSmallAdvancedTest, ZkSolrClientTest, 
TestSolrDeletionPolicy1, TestPHPSerializedResponseWriter, 
FullSolrCloudDistribCmdsTest, NodeMarkersRegistrationTest, 
HdfsUnloadDistributedZkTest, TestUseDocValuesAsStored2, TestManagedResource, 
TestExactStatsCache, TestAnalyzeInfixSuggestions, TestPullReplica, 
SuggesterFSTTest, BlobRepositoryCloudTest, TriLevelCompositeIdRoutingTest, 
RandomizedTaggerTest, TestMissingGroups, TestSystemCollAutoCreate, 
PrimUtilsTest, MaxSizeAutoCommitTest, TestJsonFacetErrors, CheckHdfsIndexTest, 
ReplaceNodeTest, TestSolrQueryParser, HdfsLockFactoryTest, 
DisMaxRequestHandlerTest, OverseerTest, TestFieldCacheWithThreads, 
TestHashQParserPlugin, TestDistributedMissingSort, TestSimDistributedQueue, 
ManagedSchemaDiffTest, TestComplexPhraseQParserPlugin, 
LeaderElectionContextKeyTest, DistributedSuggestComponentTest, 
AnalysisAfterCoreReloadTest, BasicFunctionalityTest, ConvertedLegacyTest, 
CursorPagingTest, OutputWriterTest, SampleTest, SolrInfoBeanTest, 
SolrTestCaseJ4Test, TestCrossCoreJoin, TestCursorMarkWithoutUniqueKey, 
TestDistributedGrouping, TestGroupingSearch, TestSimpleTrackingShardHandler, 
TestSolrCoreProperties, TestTolerantSearch, TestTrie, 
PathHierarchyTokenizerFactoryTest, ProtectedTermFilterFactoryTest, 
TestCharFilters, TestDeprecatedFilters, TestLuceneIndexBackCompat, 
BasicDistributedZk2Test, ChaosMonkeyNothingIsSafeWithPullReplicasTest, 
ChaosMonkeySafeLeaderTest, CleanupOldIndexTest, 
CloudExitableDirectoryReaderTest, CollectionPropsTest, DeleteNodeTest, 
DeleteShardTest, DistributedQueueTest, DistributedVersionInfoTest, 
DocValuesNotIndexedTest]
   [junit4] Completed [459/947 (1!)] on J0 in 4.02s, 5 tests, 1 failure <<< 
FAILURES!

[...truncated 55912 lines...]

---------------------------------------------------------------------
To unsubscribe, e-mail: builds-unsubscr...@lucene.apache.org
For additional commands, e-mail: builds-h...@lucene.apache.org