Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Windows/334/
Java: 64bit/jdk-9.0.1 -XX:+UseCompressedOops -XX:+UseG1GC

4 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.lucene.store.TestMultiMMap

Error Message:
Could not remove the following files (in the order of attempts):    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_EB6489FD4EAB36A2-001\testSeekZero-031:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_EB6489FD4EAB36A2-001\testSeekZero-031
    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_EB6489FD4EAB36A2-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_EB6489FD4EAB36A2-001
 

Stack Trace:
java.io.IOException: Could not remove the following files (in the order of 
attempts):
   
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_EB6489FD4EAB36A2-001\testSeekZero-031:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_EB6489FD4EAB36A2-001\testSeekZero-031
   
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_EB6489FD4EAB36A2-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_EB6489FD4EAB36A2-001

        at __randomizedtesting.SeedInfo.seed([EB6489FD4EAB36A2]:0)
        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
        at 
org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216)
        at 
com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:844)


FAILED:  
junit.framework.TestSuite.org.apache.solr.cloud.hdfs.HdfsRecoverLeaseTest

Error Message:
HDFS tests were disabled by -Dtests.disableHdfs

Stack Trace:
com.carrotsearch.randomizedtesting.InternalAssumptionViolatedException: HDFS 
tests were disabled by -Dtests.disableHdfs
        at __randomizedtesting.SeedInfo.seed([B485260F022B8D8E]:0)
        at 
com.carrotsearch.randomizedtesting.RandomizedTest.assumeTrue(RandomizedTest.java:722)
        at 
com.carrotsearch.randomizedtesting.RandomizedTest.assumeFalse(RandomizedTest.java:730)
        at 
org.apache.lucene.util.LuceneTestCase.assumeFalse(LuceneTestCase.java:866)
        at 
org.apache.solr.cloud.hdfs.HdfsTestUtil.setupClass(HdfsTestUtil.java:71)
        at 
org.apache.solr.cloud.hdfs.HdfsTestUtil.setupClass(HdfsTestUtil.java:67)
        at 
org.apache.solr.cloud.hdfs.HdfsRecoverLeaseTest.beforeClass(HdfsRecoverLeaseTest.java:50)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:564)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:874)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:844)


FAILED:  
junit.framework.TestSuite.org.apache.solr.cloud.hdfs.HdfsRecoverLeaseTest

Error Message:
Could not remove the following files (in the order of attempts):    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.hdfs.HdfsRecoverLeaseTest_B485260F022B8D8E-001\tempDir-001:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.hdfs.HdfsRecoverLeaseTest_B485260F022B8D8E-001\tempDir-001
    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.hdfs.HdfsRecoverLeaseTest_B485260F022B8D8E-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.hdfs.HdfsRecoverLeaseTest_B485260F022B8D8E-001
 

Stack Trace:
java.io.IOException: Could not remove the following files (in the order of 
attempts):
   
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.hdfs.HdfsRecoverLeaseTest_B485260F022B8D8E-001\tempDir-001:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.hdfs.HdfsRecoverLeaseTest_B485260F022B8D8E-001\tempDir-001
   
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.hdfs.HdfsRecoverLeaseTest_B485260F022B8D8E-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.hdfs.HdfsRecoverLeaseTest_B485260F022B8D8E-001

        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
        at 
org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216)
        at 
com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:844)


FAILED:  org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testEventQueue

Error Message:
action wasn't interrupted

Stack Trace:
java.lang.AssertionError: action wasn't interrupted
        at 
__randomizedtesting.SeedInfo.seed([B485260F022B8D8E:7D3064A10B4C4B7B]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at 
org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testEventQueue(TriggerIntegrationTest.java:705)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:564)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:844)




Build Log:
[...truncated 445 lines...]
   [junit4] Suite: org.apache.lucene.store.TestMultiMMap
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{docid=Lucene50(blocksize=128), junk=FST50}, docValues:{}, 
maxPointsInLeafNode=525, maxMBSortInHeap=6.53609018365548, 
sim=RandomSimilarity(queryNorm=false): {}, locale=smn-FI, 
timezone=Pacific/Honolulu
   [junit4]   2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 9.0.1 
(64-bit)/cpus=3,threads=1,free=52451152,total=108003328
   [junit4]   2> NOTE: All tests run in this JVM: [TestParallelCompositeReader, 
TestIndexSorting, TestWildcardRandom, TestRegexpQuery, TestEarlyTermination, 
TestFieldsReader, TestLucene50StoredFieldsFormat, TestOmitPositions, 
TestDocsWithFieldSet, TestSingleInstanceLockFactory, 
TestApproximationSearchEquivalence, TestSpansEnum, TestSumDocFreq, 
TestPhrasePrefixQuery, TestTopDocsMerge, TestExceedMaxTermLength, 
TestLockFactory, TestLazyProxSkipping, TestFlushByRamOrCountsPolicy, 
TestDocument, TestTryDelete, TestCrash, TestStringHelper, 
TestLucene70SegmentInfoFormat, TestAddIndexes, TestToken, TestPriorityQueue, 
TestMultiset, TestIndexableField, TestSearch, TestAtomicUpdate, 
TestBinaryDocValuesUpdates, TestNamedSPILoader, TestDuelingCodecs, 
TestMathUtil, TestAssertions, TestMultiMMap]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestMultiMMap 
-Dtests.seed=EB6489FD4EAB36A2 -Dtests.slow=true -Dtests.locale=smn-FI 
-Dtests.timezone=Pacific/Honolulu -Dtests.asserts=true 
-Dtests.file.encoding=Cp1252
   [junit4] ERROR   0.00s J0 | TestMultiMMap (suite) <<<
   [junit4]    > Throwable #1: java.io.IOException: Could not remove the 
following files (in the order of attempts):
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_EB6489FD4EAB36A2-001\testSeekZero-031:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_EB6489FD4EAB36A2-001\testSeekZero-031
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_EB6489FD4EAB36A2-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_EB6489FD4EAB36A2-001
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([EB6489FD4EAB36A2]:0)
   [junit4]    >        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
   [junit4]    >        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4] Completed [72/458 (1!)] on J0 in 4.94s, 54 tests, 1 error <<< 
FAILURES!

[...truncated 13153 lines...]
   [junit4] Suite: org.apache.solr.cloud.hdfs.HdfsRecoverLeaseTest
   [junit4]   2> Creating dataDir: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.hdfs.HdfsRecoverLeaseTest_B485260F022B8D8E-001\init-core-data-001
   [junit4]   2> 2725968 INFO  
(SUITE-HdfsRecoverLeaseTest-seed#[B485260F022B8D8E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 2725970 INFO  
(SUITE-HdfsRecoverLeaseTest-seed#[B485260F022B8D8E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 2725970 INFO  
(SUITE-HdfsRecoverLeaseTest-seed#[B485260F022B8D8E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 2725984 INFO  
(SUITE-HdfsRecoverLeaseTest-seed#[B485260F022B8D8E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ------------------------------------------------------- 
Done waiting for tracked resources to be released
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, 
docValues:{}, maxPointsInLeafNode=1493, maxMBSortInHeap=5.880274536972369, 
sim=RandomSimilarity(queryNorm=false): {}, locale=kab-DZ, 
timezone=Asia/Krasnoyarsk
   [junit4]   2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 9.0.1 
(64-bit)/cpus=3,threads=1,free=247005376,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [CoreAdminHandlerTest, 
TestRestoreCore, CoreAdminRequestStatusTest, TestSolrDeletionPolicy1, 
TestFieldTypeResource, HttpPartitionTest, TestExtendedDismaxParser, 
TestEmbeddedSolrServerConstructors, TestMultiWordSynonyms, 
FieldMutatingUpdateProcessorTest, TestShardHandlerFactory, 
TriLevelCompositeIdRoutingTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, 
OverseerTaskQueueTest, TestXmlQParser, BadComponentTest, 
TestConfigSetsAPIExclusivity, TestFaceting, TestCustomDocTransformer, 
AnalysisAfterCoreReloadTest, ConcurrentDeleteAndCreateCollectionTest, 
TestMaxScoreQueryParser, ShardSplitTest, TimeRoutedAliasUpdateProcessorTest, 
TestCorePropertiesReload, SolrPluginUtilsTest, UpdateLogTest, 
AnalyticsMergeStrategyTest, TestCloudManagedSchema, 
TestCopyFieldCollectionResource, HdfsRecoveryZkTest, 
TestReplicationHandlerBackup, TestStressLiveNodes, SolrMetricManagerTest, 
TestCryptoKeys, DistributedFacetPivotSmallTest, TestRetrieveFieldsOptimizer, 
TestStressVersions, TestPerFieldSimilarity, TestFieldResource, 
TestDelegationWithHadoopAuth, TestAuthorizationFramework, 
TestHttpShardHandlerFactory, TestShortCircuitedRequests, MultiThreadedOCPTest, 
TestLuceneIndexBackCompat, TestAuthenticationFramework, TestSolrIndexConfig, 
ZkSolrClientTest, SolrIndexConfigTest, EnumFieldTest, RuleEngineTest, 
MissingSegmentRecoveryTest, TestLeaderInitiatedRecoveryThread, 
TestStressReorder, TestSSLRandomization, TestSimpleTrackingShardHandler, 
HighlighterMaxOffsetTest, SimpleCollectionCreateDeleteTest, FullHLLTest, 
LukeRequestHandlerTest, TestZkChroot, DocumentBuilderTest, TestApiFramework, 
TestDistribDocBasedVersion, TestConfigsApi, CachingDirectoryFactoryTest, 
SuggestComponentContextFilterQueryTest, TestPartialUpdateDeduplication, 
ShardRoutingCustomTest, BlobRepositoryCloudTest, TestScoreJoinQPNoScore, 
TestCloudInspectUtil, TestFastWriter, CopyFieldTest, SolrCloudReportersTest, 
TestComplexPhraseQParserPlugin, TestUninvertingReader, DebugComponentTest, 
MetricUtilsTest, CursorMarkTest, TestBM25SimilarityFactory, RequestLoggingTest, 
SegmentsInfoRequestHandlerTest, TermVectorComponentDistributedTest, 
DistributedIntervalFacetingTest, BasicDistributedZk2Test, TestSystemIdResolver, 
MetricsConfigTest, TestStressCloudBlindAtomicUpdates, TestClusterProperties, 
TestPullReplica, TestFieldCacheReopen, SpellingQueryConverterTest, 
ReplaceNodeTest, SearchRateTriggerTest, RestartWhileUpdatingTest, 
DeleteLastCustomShardedReplicaTest, SimplePostToolTest, 
RecoveryAfterSoftCommitTest, AutoscalingHistoryHandlerTest, 
PropertiesRequestHandlerTest, CloudExitableDirectoryReaderTest, 
TestFastLRUCache, TestInfoStreamLogging, DateRangeFieldTest, 
SolrJmxReporterTest, HdfsDirectoryTest, TestSkipOverseerOperations, 
ActionThrottleTest, PreAnalyzedFieldTest, SmileWriterTest, 
TestMinMaxOnMultiValuedField, QueryEqualityTest, BasicAuthStandaloneTest, 
TestFieldCacheSortRandom, TestFastOutputStream, TestSort, 
WrapperMergePolicyFactoryTest, TestCloudRecovery, 
TestLeaderElectionWithEmptyReplica, CoreSorterTest, 
CloneFieldUpdateProcessorFactoryTest, TestConfigSetProperties, 
PreAnalyzedFieldManagedSchemaCloudTest, 
OutOfBoxZkACLAndCredentialsProvidersTest, TestFunctionQuery, 
TestLMJelinekMercerSimilarityFactory, TestCrossCoreJoin, 
DirectSolrSpellCheckerTest, TestGroupingSearch, TestSQLHandlerNonCloud, 
V2ApiIntegrationTest, CollectionsAPIDistributedZkTest, 
TestPayloadScoreQParserPlugin, TestHashPartitioner, SimpleFacetsTest, 
SolrIndexSplitterTest, TestUtilizeNode, TestExactSharedStatsCache, 
TestSolrCLIRunExample, SimpleMLTQParserTest, CdcrVersionReplicationTest, 
LeaderInitiatedRecoveryOnCommitTest, HdfsSyncSliceTest, 
BaseCdcrDistributedZkTest, BitVectorTest, ConjunctionSolrSpellCheckerTest, 
QueryElevationComponentTest, TestDynamicFieldResource, TestSolrCloudSnapshots, 
CdcrBootstrapTest, HLLUtilTest, OverseerCollectionConfigSetProcessorTest, 
TestPolicyCloud, TestStressLucene, TestChildDocTransformer, 
HdfsTlogReplayBufferedWhileIndexingTest, TestRTGBase, 
TestCollapseQParserPlugin, PluginInfoTest, TestRestManager, 
TestDistributedGrouping, TestGraphTermsQParserPlugin, BlockJoinFacetSimpleTest, 
LeaderFailoverAfterPartitionTest, UpdateRequestProcessorFactoryTest, 
MBeansHandlerTest, SOLR749Test, TestWordDelimiterFilterFactory, 
TestPostingsSolrHighlighter, AliasIntegrationTest, 
FullSolrCloudDistribCmdsTest, SystemInfoHandlerTest, 
TestSolrConfigHandlerConcurrent, DocumentAnalysisRequestHandlerTest, 
TestFieldSortValues, UUIDUpdateProcessorFallbackTest, TestCharFilters, 
TestTrackingShardHandlerFactory, TestDistributedMissingSort, 
TestCollationFieldDocValues, TestDocSet, LeaderElectionIntegrationTest, 
TestDynamicLoading, DistributedSuggestComponentTest, CleanupOldIndexTest, 
CollectionStateFormat2Test, CollectionTooManyReplicasTest, 
CollectionsAPIAsyncDistributedZkTest, ConnectionManagerTest, 
CreateCollectionCleanupTest, DeleteInactiveReplicaTest, DeleteNodeTest, 
DeleteReplicaTest, DistribDocExpirationUpdateProcessorTest, 
MoveReplicaHDFSTest, MoveReplicaTest, ReplicationFactorTest, 
RollingRestartTest, SolrXmlInZkTest, TestCloudDeleteByQuery, 
TestCloudPivotFacet, TestCollectionAPI, TestCollectionsAPIViaSolrCloudCluster, 
TestDownShardTolerantSearch, TestLocalFSCloudBackupRestore, TestPrepRecovery, 
TestRandomFlRTGCloud, TestRebalanceLeaders, TestReplicaProperties, 
TestRequestForwarding, TestRequestStatusCollectionAPI, TestSegmentSorting, 
TestTolerantUpdateProcessorCloud, VMParamsZkACLAndCredentialsProvidersTest, 
ZkFailoverTest, AutoAddReplicasPlanActionTest, ComputePlanActionTest, 
ExecutePlanActionTest, SystemLogListenerTest, CdcrBidirectionalTest, 
CdcrReplicationDistributedZkTest, CdcrReplicationHandlerTest, 
HdfsBasicDistributedZkTest, HdfsChaosMonkeySafeLeaderTest, 
HdfsCollectionsAPIDistributedZkTest, HdfsNNFailoverTest, HdfsRecoverLeaseTest]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=HdfsRecoverLeaseTest -Dtests.seed=B485260F022B8D8E -Dtests.slow=true 
-Dtests.locale=kab-DZ -Dtests.timezone=Asia/Krasnoyarsk -Dtests.asserts=true 
-Dtests.file.encoding=Cp1252
   [junit4] ERROR   0.00s J1 | HdfsRecoverLeaseTest (suite) <<<
   [junit4]    > Assumption #1: HDFS tests were disabled by 
-Dtests.disableHdfsThrowable #2: java.io.IOException: Could not remove the 
following files (in the order of attempts):
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.hdfs.HdfsRecoverLeaseTest_B485260F022B8D8E-001\tempDir-001:
 java.nio.file.AccessDeniedException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.hdfs.HdfsRecoverLeaseTest_B485260F022B8D8E-001\tempDir-001
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.hdfs.HdfsRecoverLeaseTest_B485260F022B8D8E-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.hdfs.HdfsRecoverLeaseTest_B485260F022B8D8E-001
   [junit4]    >        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
   [junit4]    >        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4] Completed [579/751 (1!)] on J1 in 0.05s, 0 tests, 1 error <<< 
FAILURES!

[...truncated 54 lines...]
   [junit4] Suite: org.apache.solr.cloud.autoscaling.TriggerIntegrationTest
   [junit4]   2> Creating dataDir: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.TriggerIntegrationTest_B485260F022B8D8E-001\init-core-data-001
   [junit4]   2> 2670789 INFO  
(SUITE-TriggerIntegrationTest-seed#[B485260F022B8D8E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 2670790 INFO  
(SUITE-TriggerIntegrationTest-seed#[B485260F022B8D8E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 2670790 INFO  
(SUITE-TriggerIntegrationTest-seed#[B485260F022B8D8E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 2670791 INFO  
(SUITE-TriggerIntegrationTest-seed#[B485260F022B8D8E]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.TriggerIntegrationTest_B485260F022B8D8E-001\tempDir-001
   [junit4]   2> 2670791 INFO  
(SUITE-TriggerIntegrationTest-seed#[B485260F022B8D8E]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2670791 INFO  (Thread-5667) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2670791 INFO  (Thread-5667) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 2670794 ERROR (Thread-5667) [    ] o.a.z.s.ZooKeeperServer 
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action 
on ERROR or SHUTDOWN server state changes
   [junit4]   2> 2670892 INFO  
(SUITE-TriggerIntegrationTest-seed#[B485260F022B8D8E]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:62549
   [junit4]   2> 2670894 INFO  (zkConnectionManagerCallback-6624-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2670897 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x1603b7eba2a0000, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> 2670898 INFO  (jetty-launcher-6621-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 2670899 INFO  (jetty-launcher-6621-thread-2) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 2670899 INFO  (jetty-launcher-6621-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@29833692{/solr,null,AVAILABLE}
   [junit4]   2> 2670899 INFO  (jetty-launcher-6621-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3b846034{/solr,null,AVAILABLE}
   [junit4]   2> 2670901 INFO  (jetty-launcher-6621-thread-2) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@6a51aac5{HTTP/1.1,[http/1.1]}{127.0.0.1:62562}
   [junit4]   2> 2670901 INFO  (jetty-launcher-6621-thread-2) [    ] 
o.e.j.s.Server Started @2681206ms
   [junit4]   2> 2670901 INFO  (jetty-launcher-6621-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@2c2dbda2{HTTP/1.1,[http/1.1]}{127.0.0.1:62560}
   [junit4]   2> 2670904 INFO  (jetty-launcher-6621-thread-1) [    ] 
o.e.j.s.Server Started @2681208ms
   [junit4]   2> 2670903 INFO  (jetty-launcher-6621-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=62562}
   [junit4]   2> 2670904 INFO  (jetty-launcher-6621-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=62560}
   [junit4]   2> 2670904 ERROR (jetty-launcher-6621-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2670904 ERROR (jetty-launcher-6621-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2670904 INFO  (jetty-launcher-6621-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.3.0
   [junit4]   2> 2670905 INFO  (jetty-launcher-6621-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.3.0
   [junit4]   2> 2670905 INFO  (jetty-launcher-6621-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2670905 INFO  (jetty-launcher-6621-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2670905 INFO  (jetty-launcher-6621-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2670905 INFO  (jetty-launcher-6621-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2670905 INFO  (jetty-launcher-6621-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-12-09T13:37:29.241066400Z
   [junit4]   2> 2670905 INFO  (jetty-launcher-6621-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-12-09T13:37:29.241066400Z
   [junit4]   2> 2670907 INFO  (zkConnectionManagerCallback-6626-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2670907 INFO  (zkConnectionManagerCallback-6628-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2670908 INFO  (jetty-launcher-6621-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2670908 INFO  (jetty-launcher-6621-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2670911 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x1603b7eba2a0001, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> 2670913 INFO  (jetty-launcher-6621-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:62549/solr
   [junit4]   2> 2670915 INFO  (jetty-launcher-6621-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:62549/solr
   [junit4]   2> 2670916 INFO  (zkConnectionManagerCallback-6632-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2670916 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x1603b7eba2a0003, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> 2670917 INFO  (zkConnectionManagerCallback-6636-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2670918 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x1603b7eba2a0004, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> 2670919 INFO  
(zkConnectionManagerCallback-6638-thread-1-processing-n:127.0.0.1:62560_solr) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2670920 INFO  
(zkConnectionManagerCallback-6640-thread-1-processing-n:127.0.0.1:62562_solr) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2671009 INFO  (jetty-launcher-6621-thread-1) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2671010 INFO  (jetty-launcher-6621-thread-1) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:62560_solr
   [junit4]   2> 2671010 INFO  (jetty-launcher-6621-thread-1) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.Overseer Overseer 
(id=99144607277383685-127.0.0.1:62560_solr-n_0000000000) starting
   [junit4]   2> 2671015 INFO  (jetty-launcher-6621-thread-2) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2671016 INFO  (jetty-launcher-6621-thread-2) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:62562_solr
   [junit4]   2> 2671018 INFO  (jetty-launcher-6621-thread-1) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:62560_solr
   [junit4]   2> 2671018 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383685-127.0.0.1:62560_solr-n_0000000000)
 [n:127.0.0.1:62560_solr    ] o.a.s.c.a.OverseerTriggerThread Adding 
.autoAddReplicas trigger
   [junit4]   2> 2671018 INFO  
(OverseerStateUpdate-99144607277383685-127.0.0.1:62560_solr-n_0000000000) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 2671019 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383685-127.0.0.1:62560_solr-n_0000000000)
 [n:127.0.0.1:62560_solr    ] o.a.s.c.a.OverseerTriggerThread Refreshing 
/autoscaling.json with znode version 1
   [junit4]   2> 2671020 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383685-127.0.0.1:62560_solr-n_0000000000)
 [n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeLostTrigger Initial livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2671020 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383685-127.0.0.1:62560_solr-n_0000000000)
 [n:127.0.0.1:62560_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 1, lastZnodeVersion -1
   [junit4]   2> 2671020 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383685-127.0.0.1:62560_solr-n_0000000000)
 [n:127.0.0.1:62560_solr    ] o.a.s.c.a.OverseerTriggerThread Processed trigger 
updates upto znodeVersion 1
   [junit4]   2> 2671022 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383685-127.0.0.1:62560_solr-n_0000000000)
 [n:127.0.0.1:62560_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeAdded markers
   [junit4]   2> 2671023 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383685-127.0.0.1:62560_solr-n_0000000000)
 [n:127.0.0.1:62560_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 2671023 INFO  
(zkCallback-6639-thread-1-processing-n:127.0.0.1:62562_solr) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 2671023 DEBUG (ScheduledTrigger-11868-thread-1) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: [127.0.0.1:62560_solr, 
127.0.0.1:62562_solr]
   [junit4]   2> 2671064 INFO  (jetty-launcher-6621-thread-1) 
[n:127.0.0.1:62560_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_62560.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@4590fe1f
   [junit4]   2> 2671071 INFO  (jetty-launcher-6621-thread-1) 
[n:127.0.0.1:62560_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_62560.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@4590fe1f
   [junit4]   2> 2671071 INFO  (jetty-launcher-6621-thread-1) 
[n:127.0.0.1:62560_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_62560.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@4590fe1f
   [junit4]   2> 2671072 INFO  (jetty-launcher-6621-thread-1) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.TriggerIntegrationTest_B485260F022B8D8E-001\tempDir-001\node2\.
   [junit4]   2> 2671074 INFO  (jetty-launcher-6621-thread-2) 
[n:127.0.0.1:62562_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_62562.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@4590fe1f
   [junit4]   2> 2671081 INFO  (jetty-launcher-6621-thread-2) 
[n:127.0.0.1:62562_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_62562.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@4590fe1f
   [junit4]   2> 2671081 INFO  (jetty-launcher-6621-thread-2) 
[n:127.0.0.1:62562_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_62562.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@4590fe1f
   [junit4]   2> 2671082 INFO  (jetty-launcher-6621-thread-2) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.TriggerIntegrationTest_B485260F022B8D8E-001\tempDir-001\node1\.
   [junit4]   2> 2671109 INFO  (zkConnectionManagerCallback-6645-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2671113 INFO  (zkConnectionManagerCallback-6649-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2671114 INFO  
(SUITE-TriggerIntegrationTest-seed#[B485260F022B8D8E]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 2671116 INFO  
(SUITE-TriggerIntegrationTest-seed#[B485260F022B8D8E]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:62549/solr ready
   [junit4]   2> 2671130 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testEventFromRestoredState
   [junit4]   2> 2671131 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.c.a.TriggerIntegrationTest /autoscaling.json reset, new znode 
version 2
   [junit4]   2> 2671132 DEBUG 
(zkCallback-6637-thread-1-processing-n:127.0.0.1:62560_solr) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.OverseerTriggerThread Refreshing 
/autoscaling.json with znode version 2
   [junit4]   2> 2671132 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383685-127.0.0.1:62560_solr-n_0000000000)
 [n:127.0.0.1:62560_solr    ] o.a.s.c.a.OverseerTriggerThread Processed trigger 
updates upto znodeVersion 2
   [junit4]   2> 2671135 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383685-127.0.0.1:62560_solr-n_0000000000)
 [n:127.0.0.1:62560_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeLost markers
   [junit4]   2> 2671135 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383685-127.0.0.1:62560_solr-n_0000000000)
 [n:127.0.0.1:62560_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeAdded markers
   [junit4]   2> 2671135 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383685-127.0.0.1:62560_solr-n_0000000000)
 [n:127.0.0.1:62560_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 2, lastZnodeVersion 2
   [junit4]   2> 2671142 INFO  
(zkConnectionManagerCallback-6653-thread-1-processing-n:127.0.0.1:62560_solr) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2671143 INFO  (qtp918927917-27542) [n:127.0.0.1:62560_solr    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 2671144 INFO  (qtp918927917-27542) [n:127.0.0.1:62560_solr    
] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:62549/solr ready
   [junit4]   2> 2671145 INFO  (qtp918927917-27540) [n:127.0.0.1:62560_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0 
QTime=0
   [junit4]   2> 2671147 INFO  (qtp1433621788-27551) [n:127.0.0.1:62562_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0 
QTime=0
   [junit4]   2> 2671147 DEBUG (qtp918927917-27542) [n:127.0.0.1:62560_solr    
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 2671148 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x1603b7eba2a0009, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> 2671148 INFO  (qtp918927917-27542) [n:127.0.0.1:62560_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling 
params={wt=javabin&version=2} status=0 QTime=9
   [junit4]   2> 2671149 DEBUG 
(zkCallback-6637-thread-1-processing-n:127.0.0.1:62560_solr) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.OverseerTriggerThread Refreshing 
/autoscaling.json with znode version 3
   [junit4]   2> 2671150 DEBUG 
(zkCallback-6637-thread-1-processing-n:127.0.0.1:62560_solr) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Initial livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2671150 DEBUG 
(zkCallback-6637-thread-1-processing-n:127.0.0.1:62560_solr) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger 
node_added_trigger instantiated with properties: {event=nodeAdded, waitFor=10, 
actions=[{name=test, 
class=org.apache.solr.cloud.autoscaling.TriggerIntegrationTest$TestTriggerAction}],
 enabled=true}
   [junit4]   2> 2671150 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383685-127.0.0.1:62560_solr-n_0000000000)
 [n:127.0.0.1:62560_solr    ] o.a.s.c.a.OverseerTriggerThread Processed trigger 
updates upto znodeVersion 3
   [junit4]   2> 2671151 INFO  
(OverseerAutoScalingTriggerThread-99144607277383685-127.0.0.1:62560_solr-n_0000000000)
 [n:127.0.0.1:62560_solr    ] o.a.s.c.a.TriggerIntegrationTest 
TestTriggerAction init
   [junit4]   2> 2671152 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383685-127.0.0.1:62560_solr-n_0000000000)
 [n:127.0.0.1:62560_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeLost markers
   [junit4]   2> 2671152 INFO  (qtp918927917-27539) [n:127.0.0.1:62560_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with 
params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 2671152 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383685-127.0.0.1:62560_solr-n_0000000000)
 [n:127.0.0.1:62560_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 3, lastZnodeVersion 3
   [junit4]   2> 2671153 DEBUG (ScheduledTrigger-11868-thread-1) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2671153 DEBUG (ScheduledTrigger-11868-thread-1) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2671157 INFO  (qtp918927917-27539) [n:127.0.0.1:62560_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=4
   [junit4]   2> 2671158 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 2671159 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6eb517ba{/solr,null,AVAILABLE}
   [junit4]   2> 2671159 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@6d2f8b52{HTTP/1.1,[http/1.1]}{127.0.0.1:62596}
   [junit4]   2> 2671160 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.e.j.s.Server Started @2681464ms
   [junit4]   2> 2671160 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=62596}
   [junit4]   2> 2671160 ERROR 
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 2671160 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 7.3.0
   [junit4]   2> 2671160 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on 
port null
   [junit4]   2> 2671160 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2671160 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-12-09T13:37:29.496555600Z
   [junit4]   2> 2671162 INFO  (zkConnectionManagerCallback-6655-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2671163 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2671167 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x1603b7eba2a000a, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> 2671169 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:62549/solr
   [junit4]   2> 2671171 INFO  (zkConnectionManagerCallback-6659-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2671172 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x1603b7eba2a000b, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> 2671177 INFO  
(zkConnectionManagerCallback-6661-thread-1-processing-n:127.0.0.1:62596_solr) 
[n:127.0.0.1:62596_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2671181 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [n:127.0.0.1:62596_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 2671183 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [n:127.0.0.1:62596_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2671185 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [n:127.0.0.1:62596_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:62596_solr
   [junit4]   2> 2671186 INFO  
(zkCallback-6639-thread-1-processing-n:127.0.0.1:62562_solr) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 2671187 INFO  
(zkCallback-6637-thread-1-processing-n:127.0.0.1:62560_solr) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 2671187 INFO  
(zkCallback-6660-thread-1-processing-n:127.0.0.1:62596_solr) 
[n:127.0.0.1:62596_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 2671188 INFO  (zkCallback-6648-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 2671243 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [n:127.0.0.1:62596_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_62596.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@4590fe1f
   [junit4]   2> 2671252 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [n:127.0.0.1:62596_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_62596.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@4590fe1f
   [junit4]   2> 2671252 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [n:127.0.0.1:62596_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_62596.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@4590fe1f
   [junit4]   2> 2671253 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [n:127.0.0.1:62596_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.TriggerIntegrationTest_B485260F022B8D8E-001\tempDir-001\node3\.
   [junit4]   2> 2672156 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2672156 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62596_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2672156 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Tracking new node: 
127.0.0.1:62596_solr at time 1512826650492000000
   [junit4]   2> 2673156 INFO  
(OverseerCollectionConfigSetProcessor-99144607277383685-127.0.0.1:62560_solr-n_0000000000)
 [n:127.0.0.1:62560_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 2673158 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2673158 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62596_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2674158 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2674158 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62596_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2675159 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2675159 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62596_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2676175 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2676175 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62596_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2677176 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2677176 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62596_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2678176 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2678176 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62596_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2679177 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2679177 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62596_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2680178 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2680178 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62596_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2681180 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2681180 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62596_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2682180 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2682180 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62596_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2682180 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger 
node_added_trigger firing registered processor for nodes: 
[127.0.0.1:62596_solr] added at times [1512826650492000000], 
now=1512826660516000000
   [junit4]   2> 2682180 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown 
inactive - processing event: {
   [junit4]   2>   "id":"14fea3d2c551d700T3rr52wb5ye4n7896suswpll0w",
   [junit4]   2>   "source":"node_added_trigger",
   [junit4]   2>   "eventTime":1512826650492000000,
   [junit4]   2>   "eventType":"NODEADDED",
   [junit4]   2>   "properties":{
   [junit4]   2>     "eventTimes":[1512826650492000000],
   [junit4]   2>     "nodeNames":["127.0.0.1:62596_solr"]}}
   [junit4]   2> 2682181 INFO  (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.SystemLogListener Collection .system 
does not exist, disabling logging.
   [junit4]   2> 2682181 DEBUG 
(AutoscalingActionExecutor-11869-thread-1-processing-n:127.0.0.1:62560_solr) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.ScheduledTriggers -- processing actions 
for {
   [junit4]   2>   "id":"14fea3d2c551d700T3rr52wb5ye4n7896suswpll0w",
   [junit4]   2>   "source":"node_added_trigger",
   [junit4]   2>   "eventTime":1512826650492000000,
   [junit4]   2>   "eventType":"NODEADDED",
   [junit4]   2>   "properties":{
   [junit4]   2>     "eventTimes":[1512826650492000000],
   [junit4]   2>     "_enqueue_time_":1512826660516000000,
   [junit4]   2>     "nodeNames":["127.0.0.1:62596_solr"]}}
   [junit4]   2> 2682183 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 2682183 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1c2e12f3{/solr,null,AVAILABLE}
   [junit4]   2> 2682184 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@30b42b6f{HTTP/1.1,[http/1.1]}{127.0.0.1:62627}
   [junit4]   2> 2682185 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.e.j.s.Server Started @2692489ms
   [junit4]   2> 2682185 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=62627}
   [junit4]   2> 2682185 ERROR 
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 2682185 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 7.3.0
   [junit4]   2> 2682185 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on 
port null
   [junit4]   2> 2682185 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2682185 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-12-09T13:37:40.521732100Z
   [junit4]   2> 2682188 INFO  (zkConnectionManagerCallback-6664-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2682188 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2682192 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x1603b7eba2a000d, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> 2682196 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:62549/solr
   [junit4]   2> 2682198 INFO  (zkConnectionManagerCallback-6668-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2682198 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x1603b7eba2a000e, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> 2682200 INFO  
(zkConnectionManagerCallback-6670-thread-1-processing-n:127.0.0.1:62627_solr) 
[n:127.0.0.1:62627_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2682208 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [n:127.0.0.1:62627_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 2682210 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [n:127.0.0.1:62627_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2682212 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [n:127.0.0.1:62627_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:62627_solr
   [junit4]   2> 2682213 INFO  
(zkCallback-6637-thread-1-processing-n:127.0.0.1:62560_solr) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2682214 INFO  
(zkCallback-6639-thread-1-processing-n:127.0.0.1:62562_solr) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2682214 INFO  
(zkCallback-6660-thread-1-processing-n:127.0.0.1:62596_solr) 
[n:127.0.0.1:62596_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2682214 INFO  (zkCallback-6648-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2682214 INFO  
(zkCallback-6669-thread-1-processing-n:127.0.0.1:62627_solr) 
[n:127.0.0.1:62627_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2682274 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [n:127.0.0.1:62627_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_62627.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@4590fe1f
   [junit4]   2> 2682282 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [n:127.0.0.1:62627_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_62627.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@4590fe1f
   [junit4]   2> 2682283 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [n:127.0.0.1:62627_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_62627.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@4590fe1f
   [junit4]   2> 2682284 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [n:127.0.0.1:62627_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.TriggerIntegrationTest_B485260F022B8D8E-001\tempDir-001\node4\.
   [junit4]   2> 2683183 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2683183 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62596_solr, 127.0.0.1:62627_solr, 
127.0.0.1:62562_solr]
   [junit4]   2> 2683183 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Tracking new node: 
127.0.0.1:62627_solr at time 1512826661519000000
   [junit4]   2> 2684185 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2684185 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62596_solr, 127.0.0.1:62627_solr, 
127.0.0.1:62562_solr]
   [junit4]   2> 2685186 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2685186 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62596_solr, 127.0.0.1:62627_solr, 
127.0.0.1:62562_solr]
   [junit4]   2> 2686186 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2686186 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62596_solr, 127.0.0.1:62627_solr, 
127.0.0.1:62562_solr]
   [junit4]   2> 2687187 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2687187 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62596_solr, 127.0.0.1:62627_solr, 
127.0.0.1:62562_solr]
   [junit4]   2> 2688217 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2688217 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62596_solr, 127.0.0.1:62627_solr, 
127.0.0.1:62562_solr]
   [junit4]   2> 2689218 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2689218 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62596_solr, 127.0.0.1:62627_solr, 
127.0.0.1:62562_solr]
   [junit4]   2> 2690219 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2690219 DEBUG (ScheduledTrigger-11868-thread-2) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62596_solr, 127.0.0.1:62627_solr, 
127.0.0.1:62562_solr]
   [junit4]   2> 2691220 DEBUG (ScheduledTrigger-11868-thread-3) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2691220 DEBUG (ScheduledTrigger-11868-thread-3) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62596_solr, 127.0.0.1:62627_solr, 
127.0.0.1:62562_solr]
   [junit4]   2> 2692221 DEBUG (ScheduledTrigger-11868-thread-1) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2692221 DEBUG (ScheduledTrigger-11868-thread-1) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62560_solr, 127.0.0.1:62596_solr, 127.0.0.1:62627_solr, 
127.0.0.1:62562_solr]
   [junit4]   2> 2692323 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@2c2dbda2{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 2692323 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1982151763
   [junit4]   2> 2692324 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.node, tag=null
   [junit4]   2> 2692324 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@e67cb1a: rootName = 
solr_62560, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@115cf253
   [junit4]   2> 2692336 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jvm, tag=null
   [junit4]   2> 2692336 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@49ab7ec8: rootName = 
solr_62560, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@1ab16f8a
   [junit4]   2> 2692346 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jetty, tag=null
   [junit4]   2> 2692346 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@6cbc75f8: rootName = 
solr_62560, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@5fb3f2b8
   [junit4]   2> 2692348 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:62560_solr
   [junit4]   2> 2692349 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.cluster, tag=null
   [junit4]   2> 2692350 INFO  
(zkCallback-6639-thread-1-processing-n:127.0.0.1:62562_solr) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (4) -> (3)
   [junit4]   2> 2692350 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 2692350 INFO  (zkCallback-6648-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 2692350 INFO  
(zkCallback-6669-thread-1-processing-n:127.0.0.1:62627_solr) 
[n:127.0.0.1:62627_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (4) -> (3)
   [junit4]   2> 2692351 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.c.Overseer Overseer 
(id=99144607277383685-127.0.0.1:62560_solr-n_0000000000) closing
   [junit4]   2> 2692350 INFO  
(zkCallback-6660-thread-1-processing-n:127.0.0.1:62596_solr) 
[n:127.0.0.1:62596_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (4) -> (3)
   [junit4]   2> 2692350 INFO  
(zkCallback-6637-thread-1-processing-n:127.0.0.1:62560_solr) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (4) -> (3)
   [junit4]   2> 2692352 INFO  
(OverseerStateUpdate-99144607277383685-127.0.0.1:62560_solr-n_0000000000) 
[n:127.0.0.1:62560_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:62560_solr
   [junit4]   2> 2692353 WARN  
(OverseerAutoScalingTriggerThread-99144607277383685-127.0.0.1:62560_solr-n_0000000000)
 [n:127.0.0.1:62560_solr    ] o.a.s.c.a.OverseerTriggerThread 
OverseerTriggerThread woken up but we are closed, exiting.
   [junit4]   2> 2692353 DEBUG 
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed 
explicitly
   [junit4]   2> 2692354 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x1603b7eba2a0005, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> 2692355 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@29833692{/solr,null,UNAVAILABLE}
   [junit4]   2> 2692355 INFO  
(zkCallback-6639-thread-1-processing-n:127.0.0.1:62562_solr) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:62562_solr
   [junit4]   2> 2692357 INFO  
(zkCallback-6639-thread-1-processing-n:127.0.0.1:62562_solr) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.Overseer Overseer 
(id=99144607277383686-127.0.0.1:62562_solr-n_0000000001) starting
   [junit4]   2> 2692368 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383686-127.0.0.1:62562_solr-n_0000000001)
 [n:127.0.0.1:62562_solr    ] o.a.s.c.a.OverseerTriggerThread Adding 
.autoAddReplicas trigger
   [junit4]   2> 2692370 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383686-127.0.0.1:62562_solr-n_0000000001)
 [n:127.0.0.1:62562_solr    ] o.a.s.c.a.OverseerTriggerThread Refreshing 
/autoscaling.json with znode version 4
   [junit4]   2> 2692371 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383686-127.0.0.1:62562_solr-n_0000000001)
 [n:127.0.0.1:62562_solr    ] o.a.s.c.a.NodeAddedTrigger Initial livenodes: 
[127.0.0.1:62596_solr, 127.0.0.1:62627_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2692371 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383686-127.0.0.1:62562_solr-n_0000000001)
 [n:127.0.0.1:62562_solr    ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger 
node_added_trigger instantiated with properties: {event=nodeAdded, waitFor=10, 
actions=[{name=test, 
class=org.apache.solr.cloud.autoscaling.TriggerIntegrationTest$TestTriggerAction}],
 enabled=true}
   [junit4]   2> 2692371 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383686-127.0.0.1:62562_solr-n_0000000001)
 [n:127.0.0.1:62562_solr    ] o.a.s.c.a.NodeLostTrigger Initial livenodes: 
[127.0.0.1:62596_solr, 127.0.0.1:62627_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2692372 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383686-127.0.0.1:62562_solr-n_0000000001)
 [n:127.0.0.1:62562_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 4, lastZnodeVersion -1
   [junit4]   2> 2692372 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383686-127.0.0.1:62562_solr-n_0000000001)
 [n:127.0.0.1:62562_solr    ] o.a.s.c.a.OverseerTriggerThread Processed trigger 
updates upto znodeVersion 4
   [junit4]   2> 2692375 INFO  
(OverseerAutoScalingTriggerThread-99144607277383686-127.0.0.1:62562_solr-n_0000000001)
 [n:127.0.0.1:62562_solr    ] o.a.s.c.a.TriggerIntegrationTest 
TestTriggerAction init
   [junit4]   2> 2692376 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383686-127.0.0.1:62562_solr-n_0000000001)
 [n:127.0.0.1:62562_solr    ] o.a.s.c.a.NodeAddedTrigger Adding node from 
marker path: 127.0.0.1:62627_solr
   [junit4]   2> 2692376 DEBUG (ScheduledTrigger-11889-thread-1) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: [127.0.0.1:62596_solr, 
127.0.0.1:62627_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2692377 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383686-127.0.0.1:62562_solr-n_0000000001)
 [n:127.0.0.1:62562_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 4, lastZnodeVersion 4
   [junit4]   2> 2692378 DEBUG (ScheduledTrigger-11889-thread-1) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2692378 DEBUG (ScheduledTrigger-11889-thread-1) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62596_solr, 127.0.0.1:62627_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2693378 DEBUG (ScheduledTrigger-11889-thread-2) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: [127.0.0.1:62596_solr, 
127.0.0.1:62627_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2693381 DEBUG (ScheduledTrigger-11889-thread-3) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger
   [junit4]   2> 2693381 DEBUG (ScheduledTrigger-11889-thread-3) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62596_solr, 127.0.0.1:62627_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2693381 DEBUG (ScheduledTrigger-11889-thread-3) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger 
node_added_trigger firing registered processor for nodes: 
[127.0.0.1:62627_solr] added at times [1512826661519000000], 
now=1512826671717000000
   [junit4]   2> 2693382 DEBUG (ScheduledTrigger-11889-thread-3) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown 
inactive - processing event: {
   [junit4]   2>   "id":"14fea3d5569481c0T3rr52wb5ye4n7896suswpll0y",
   [junit4]   2>   "source":"node_added_trigger",
   [junit4]   2>   "eventTime":1512826661519000000,
   [junit4]   2>   "eventType":"NODEADDED",
   [junit4]   2>   "properties":{
   [junit4]   2>     "eventTimes":[1512826661519000000],
   [junit4]   2>     "nodeNames":["127.0.0.1:62627_solr"]}}
   [junit4]   2> 2693383 INFO  (ScheduledTrigger-11889-thread-3) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.SystemLogListener Collection .system 
does not exist, disabling logging.
   [junit4]   2> 2693383 DEBUG 
(AutoscalingActionExecutor-11890-thread-1-processing-n:127.0.0.1:62562_solr) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.ScheduledTriggers -- processing actions 
for {
   [junit4]   2>   "id":"14fea3d5569481c0T3rr52wb5ye4n7896suswpll0y",
   [junit4]   2>   "source":"node_added_trigger",
   [junit4]   2>   "eventTime":1512826661519000000,
   [junit4]   2>   "eventType":"NODEADDED",
   [junit4]   2>   "properties":{
   [junit4]   2>     "eventTimes":[1512826661519000000],
   [junit4]   2>     "_enqueue_time_":1512826671718000000,
   [junit4]   2>     "nodeNames":["127.0.0.1:62627_solr"]}}
   [junit4]   2> 2693383 INFO  
(TEST-TriggerIntegrationTest.testEventFromRestoredState-seed#[B485260F022B8D8E])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testEventFromRestoredState
   [junit4]   2> 2693406 INFO  
(TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[B485260F022B8D8E]) [   
 ] o.a.s.SolrTestCaseJ4 ###Starting testTriggerThrottling
   [junit4]   2> 2693408 INFO  
(TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[B485260F022B8D8E]) [   
 ] o.a.s.c.a.TriggerIntegrationTest /autoscaling.json reset, new znode version 5
   [junit4]   2> 2693408 DEBUG 
(zkCallback-6639-thread-1-processing-n:127.0.0.1:62562_solr) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.OverseerTriggerThread Refreshing 
/autoscaling.json with znode version 5
   [junit4]   2> 2693408 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383686-127.0.0.1:62562_solr-n_0000000001)
 [n:127.0.0.1:62562_solr    ] o.a.s.c.a.OverseerTriggerThread Processed trigger 
updates upto znodeVersion 5
   [junit4]   2> 2693411 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383686-127.0.0.1:62562_solr-n_0000000001)
 [n:127.0.0.1:62562_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeLost markers
   [junit4]   2> 2693411 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383686-127.0.0.1:62562_solr-n_0000000001)
 [n:127.0.0.1:62562_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeAdded markers
   [junit4]   2> 2693412 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383686-127.0.0.1:62562_solr-n_0000000001)
 [n:127.0.0.1:62562_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 5, lastZnodeVersion 5
   [junit4]   2> 2693418 INFO  
(zkConnectionManagerCallback-6676-thread-1-processing-n:127.0.0.1:62562_solr) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2693420 INFO  (qtp1433621788-27548) [n:127.0.0.1:62562_solr    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 2693422 INFO  (qtp1433621788-27548) [n:127.0.0.1:62562_solr    
] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:62549/solr ready
   [junit4]   2> 2693424 INFO  (qtp1433621788-27557) [n:127.0.0.1:62562_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0 
QTime=0
   [junit4]   2> 2693427 INFO  (qtp876677697-27613) [n:127.0.0.1:62596_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0 
QTime=0
   [junit4]   2> 2693431 INFO  (qtp458081789-27638) [n:127.0.0.1:62627_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0 
QTime=0
   [junit4]   2> 2693432 DEBUG (qtp1433621788-27548) [n:127.0.0.1:62562_solr    
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 2693433 INFO  (qtp1433621788-27548) [n:127.0.0.1:62562_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling 
params={wt=javabin&version=2} status=0 QTime=18
   [junit4]   2> 2693433 DEBUG 
(zkCallback-6639-thread-1-processing-n:127.0.0.1:62562_solr) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.OverseerTriggerThread Refreshing 
/autoscaling.json with znode version 6
   [junit4]   2> 2693435 DEBUG 
(zkCallback-6639-thread-1-processing-n:127.0.0.1:62562_solr) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.NodeAddedTrigger Initial livenodes: 
[127.0.0.1:62596_solr, 127.0.0.1:62627_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2693435 DEBUG 
(zkCallback-6639-thread-1-processing-n:127.0.0.1:62562_solr) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger 
node_added_trigger1 instantiated with properties: {event=nodeAdded, waitFor=0, 
actions=[{name=test, 
class=org.apache.solr.cloud.autoscaling.TriggerIntegrationTest$ThrottlingTesterAction}],
 enabled=true}
   [junit4]   2> 2693435 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383686-127.0.0.1:62562_solr-n_0000000001)
 [n:127.0.0.1:62562_solr    ] o.a.s.c.a.OverseerTriggerThread Processed trigger 
updates upto znodeVersion 6
   [junit4]   2> 2693437 INFO  
(OverseerAutoScalingTriggerThread-99144607277383686-127.0.0.1:62562_solr-n_0000000001)
 [n:127.0.0.1:62562_solr    ] o.a.s.c.a.TriggerIntegrationTest 
TestTriggerAction init
   [junit4]   2> 2693438 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383686-127.0.0.1:62562_solr-n_0000000001)
 [n:127.0.0.1:62562_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeLost markers
   [junit4]   2> 2693439 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383686-127.0.0.1:62562_solr-n_0000000001)
 [n:127.0.0.1:62562_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 6, lastZnodeVersion 6
   [junit4]   2> 2693439 DEBUG (ScheduledTrigger-11889-thread-4) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger1
   [junit4]   2> 2693439 DEBUG (ScheduledTrigger-11889-thread-4) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62596_solr, 127.0.0.1:62627_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2693446 INFO  
(zkConnectionManagerCallback-6680-thread-1-processing-n:127.0.0.1:62596_solr) 
[n:127.0.0.1:62596_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2693451 INFO  (qtp876677697-27615) [n:127.0.0.1:62596_solr    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 2693452 INFO  (qtp876677697-27615) [n:127.0.0.1:62596_solr    
] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:62549/solr ready
   [junit4]   2> 2693454 INFO  (qtp1433621788-27558) [n:127.0.0.1:62562_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0 
QTime=0
   [junit4]   2> 2693455 INFO  (qtp876677697-27617) [n:127.0.0.1:62596_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0 
QTime=0
   [junit4]   2> 2693457 INFO  (qtp458081789-27639) [n:127.0.0.1:62627_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0 
QTime=0
   [junit4]   2> 2693458 DEBUG (qtp876677697-27615) [n:127.0.0.1:62596_solr    
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 2693459 INFO  (qtp876677697-27615) [n:127.0.0.1:62596_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling 
params={wt=javabin&version=2} status=0 QTime=23
   [junit4]   2> 2693459 DEBUG 
(zkCallback-6639-thread-1-processing-n:127.0.0.1:62562_solr) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.OverseerTriggerThread Refreshing 
/autoscaling.json with znode version 7
   [junit4]   2> 2693460 DEBUG 
(zkCallback-6639-thread-1-processing-n:127.0.0.1:62562_solr) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.NodeAddedTrigger Initial livenodes: 
[127.0.0.1:62596_solr, 127.0.0.1:62627_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2693460 DEBUG 
(zkCallback-6639-thread-1-processing-n:127.0.0.1:62562_solr) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger 
node_added_trigger2 instantiated with properties: {event=nodeAdded, waitFor=0, 
actions=[{name=test, 
class=org.apache.solr.cloud.autoscaling.TriggerIntegrationTest$ThrottlingTesterAction}],
 enabled=true}
   [junit4]   2> 2693461 DEBUG 
(zkCallback-6639-thread-1-processing-n:127.0.0.1:62562_solr) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.NodeAddedTrigger Initial livenodes: 
[127.0.0.1:62596_solr, 127.0.0.1:62627_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2693461 DEBUG 
(zkCallback-6639-thread-1-processing-n:127.0.0.1:62562_solr) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger 
node_added_trigger1 instantiated with properties: {event=nodeAdded, waitFor=0, 
actions=[{name=test, 
class=org.apache.solr.cloud.autoscaling.TriggerIntegrationTest$ThrottlingTesterAction}],
 enabled=true}
   [junit4]   2> 2693461 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383686-127.0.0.1:62562_solr-n_0000000001)
 [n:127.0.0.1:62562_solr    ] o.a.s.c.a.OverseerTriggerThread Processed trigger 
updates upto znodeVersion 7
   [junit4]   2> 2693463 INFO  
(OverseerAutoScalingTriggerThread-99144607277383686-127.0.0.1:62562_solr-n_0000000001)
 [n:127.0.0.1:62562_solr    ] o.a.s.c.a.TriggerIntegrationTest 
TestTriggerAction init
   [junit4]   2> 2693465 INFO  
(TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[B485260F022B8D8E]) [   
 ] o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 2693466 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383686-127.0.0.1:62562_solr-n_0000000001)
 [n:127.0.0.1:62562_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeLost markers
   [junit4]   2> 2693466 INFO  
(TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[B485260F022B8D8E]) [   
 ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@5f91a6ea{/solr,null,AVAILABLE}
   [junit4]   2> 2693467 INFO  
(TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[B485260F022B8D8E]) [   
 ] o.e.j.s.AbstractConnector Started 
ServerConnector@724ecbdd{HTTP/1.1,[http/1.1]}{127.0.0.1:62655}
   [junit4]   2> 2693467 INFO  
(TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[B485260F022B8D8E]) [   
 ] o.e.j.s.Server Started @2703771ms
   [junit4]   2> 2693467 INFO  
(TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[B485260F022B8D8E]) [   
 ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=62655}
   [junit4]   2> 2693467 DEBUG 
(OverseerAutoScalingTriggerThread-99144607277383686-127.0.0.1:62562_solr-n_0000000001)
 [n:127.0.0.1:62562_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 7, lastZnodeVersion 7
   [junit4]   2> 2693467 DEBUG (ScheduledTrigger-11889-thread-1) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.NodeAddedTrigger Running 
NodeAddedTrigger node_added_trigger2
   [junit4]   2> 2693467 ERROR 
(TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[B485260F022B8D8E]) [   
 ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2693467 DEBUG (ScheduledTrigger-11889-thread-1) 
[n:127.0.0.1:62562_solr    ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 
[127.0.0.1:62596_solr, 127.0.0.1:62627_solr, 127.0.0.1:62562_solr]
   [junit4]   2> 2693467 INFO  (TEST-TriggerIntegr

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

r/collections/collection1/state.json
   [junit4]   2>        6       /solr/autoscaling.json
   [junit4]   2>        2       
/solr/overseer_elect/election/99144607277383695-127.0.0.1:62627_solr-n_0000000003
   [junit4]   2>        2       
/solr/overseer_elect/election/99144607277383730-127.0.0.1:63142_solr-n_0000000011
   [junit4]   2>        2       
/solr/overseer_elect/election/99144607277383741-127.0.0.1:63288_solr-n_0000000013
   [junit4]   2>        2       
/solr/overseer_elect/election/99144607277383715-127.0.0.1:62829_solr-n_0000000007
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        45      /solr/collections
   [junit4]   2>        44      /solr/live_nodes
   [junit4]   2>        6       /solr/overseer/queue-work
   [junit4]   2>        6       /solr/autoscaling/events/.auto_add_replicas
   [junit4]   2>        6       /solr/overseer/collection-queue-work
   [junit4]   2>        5       /solr/overseer/queue
   [junit4]   2>        2       /solr/autoscaling/events/node_added_trigger
   [junit4]   2>        2       /solr/autoscaling/events/node_lost_trigger
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.TriggerIntegrationTest_B485260F022B8D8E-001
   [junit4]   2> Dec 09, 2017 1:40:09 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(Lucene70): {}, 
docValues:{}, maxPointsInLeafNode=669, maxMBSortInHeap=7.4750631865835775, 
sim=RandomSimilarity(queryNorm=true): {}, locale=ko-KP, timezone=Egypt
   [junit4]   2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 9.0.1 
(64-bit)/cpus=3,threads=1,free=317818320,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: 
[ChaosMonkeyNothingIsSafeTest, TimeZoneUtilsTest, DistribCursorPagingTest, 
TestFilteredDocIdSet, NotRequiredUniqueKeyTest, TestPushWriter, TestLFUCache, 
ForceLeaderTest, PeerSyncReplicationTest, TestRandomRequestDistribution, 
SolrJmxReporterCloudTest, GraphQueryTest, SpellCheckComponentTest, 
CloudMLTQParserTest, BasicAuthIntegrationTest, AutoScalingHandlerTest, 
OverseerModifyCollectionTest, TestNamedUpdateProcessors, 
DistributedQueryComponentOptimizationTest, 
PeerSyncWithIndexFingerprintCachingTest, CdcrRequestHandlerTest, 
SortByFunctionTest, SpellCheckCollatorWithCollapseTest, ReturnFieldsTest, 
OutputWriterTest, DateMathParserTest, TestReplicationHandler, 
TlogReplayBufferedWhileIndexingTest, TestLazyCores, 
BinaryUpdateRequestHandlerTest, TestSizeLimitedDistributedMap, 
TestLeaderElectionZkExpiry, UnloadDistributedZkTest, TestFiltering, 
TestClassicSimilarityFactory, TestUnifiedSolrHighlighter, HdfsThreadLeakTest, 
DistributedSpellCheckComponentTest, TestMaxTokenLenTokenizer, TestInitParams, 
TestMiniSolrCloudClusterSSL, AnalyticsQueryTest, TestCustomSort, 
TestLMDirichletSimilarityFactory, TestHdfsCloudBackupRestore, 
NoCacheHeaderTest, ResponseHeaderTest, TestSweetSpotSimilarityFactory, 
SolrGangliaReporterTest, SolrRequestParserTest, SuggesterFSTTest, 
HdfsUnloadDistributedZkTest, SharedFSAutoReplicaFailoverTest, 
TestSolrCoreParser, HdfsDirectoryFactoryTest, 
AsyncCallRequestStatusResponseTest, CoreAdminCreateDiscoverTest, 
BooleanFieldTest, TestBulkSchemaAPI, DocExpirationUpdateProcessorFactoryTest, 
SignatureUpdateProcessorFactoryTest, TestSurroundQueryParser, CursorPagingTest, 
TestTolerantSearch, TestOrdValues, TestCloudJSONFacetJoinDomain, 
ClassificationUpdateProcessorTest, RequiredFieldsTest, 
HdfsChaosMonkeyNothingIsSafeTest, TestConfigSetsAPI, TestPointFields, 
DistanceFunctionTest, ZkCLITest, TestHalfAndHalfDocValues, TestRawTransformer, 
DocValuesMissingTest, TestRealTimeGet, TestCodecSupport, UUIDFieldTest, 
ImplicitSnitchTest, IndexBasedSpellCheckerTest, 
LeaderFailureAfterFreshStartTest, TestHashQParserPlugin, TestPhraseSuggestions, 
TestSystemCollAutoCreate, WordBreakSolrSpellCheckerTest, TestLegacyFieldReuse, 
DistributedVersionInfoTest, TestLegacyTerms, TestFieldCacheSort, 
TestConfigReload, TestFieldCacheVsDocValues, 
ChaosMonkeySafeLeaderWithPullReplicasTest, TestBulkSchemaConcurrent, 
IndexSchemaTest, DistributedFacetPivotSmallAdvancedTest, PrimUtilsTest, 
TestExactStatsCache, TestExportWriter, TestPivotHelperCode, 
HdfsBasicDistributedZk2Test, FastVectorHighlighterTest, SolrSlf4jReporterTest, 
TestDocBasedVersionConstraints, TestNumericTokenStream, 
TestImplicitCoreProperties, TestCollectionAPIs, CurrencyFieldTypeTest, 
TestStressInPlaceUpdates, TestGraphMLResponseWriter, TestJoin, 
HdfsRestartWhileUpdatingTest, TestManagedResourceStorage, MetricsHandlerTest, 
BJQParserTest, NodeMutatorTest, SolrCoreMetricManagerTest, 
URLClassifyProcessorTest, CollectionReloadTest, TestRecoveryHdfs, 
TestTolerantUpdateProcessorRandomCloud, ClusterStateUpdateTest, 
TestPKIAuthenticationPlugin, DistribJoinFromCollectionTest, 
DirectUpdateHandlerTest, SolrInfoBeanTest, TestManagedSchemaAPI, 
TestJmxIntegration, TestCursorMarkWithoutUniqueKey, TestSolrDeletionPolicy2, 
ResponseLogComponentTest, TestLegacyNumericRangeQueryBuilder, 
TestOmitPositions, MoveReplicaHDFSFailoverTest, OverseerTest, 
FieldAnalysisRequestHandlerTest, SpatialFilterTest, TestConfigSets, 
TestSolrXml, SecurityConfHandlerTest, HighlighterTest, 
ClassificationUpdateProcessorFactoryTest, TestNumericRangeQuery32, 
RAMDirectoryFactoryTest, TestDistribIDF, TestUseDocValuesAsStored2, 
ShowFileRequestHandlerTest, TestJsonFacets, CSVRequestHandlerTest, 
DateFieldTest, TestHdfsBackupRestoreCore, TestFuzzyAnalyzedSuggestions, 
AssignBackwardCompatibilityTest, AtomicUpdateProcessorFactoryTest, 
TestSchemaSimilarityResource, TestSerializedLuceneMatchVersion, 
HdfsLockFactoryTest, BasicDistributedZkTest, DirectSolrConnectionTest, 
ConfigSetsAPITest, DisMaxRequestHandlerTest, UninvertDocValuesMergePolicyTest, 
TestSchemalessBufferedUpdates, TestSimpleTextCodec, TestTrieFacet, 
PKIAuthenticationIntegrationTest, LeaderElectionTest, TestQueryWrapperFilter, 
NodeLostTriggerTest, ParsingFieldUpdateProcessorsTest, RegexBoostProcessorTest, 
SearchHandlerTest, TestWriterPerf, SolrCLIZkUtilsTest, 
BlockJoinFacetRandomTest, NumericFieldsTest, TestReqParamsAPI, TestUtils, 
DistributedFacetPivotLargeTest, CoreMergeIndexesAdminHandlerTest, 
RecoveryZkTest, TestInPlaceUpdatesStandalone, TestNestedDocsSort, 
ChaosMonkeySafeLeaderTest, SyncSliceTest, OpenCloseCoreStressTest, 
ShardRoutingTest, BasicZkTest, TestRandomFaceting, TestRandomDVFaceting, 
TestDistributedSearch, TestRecovery, ZkControllerTest, TestReload, 
DistributedTermsComponentTest, TestRangeQuery, TestCoreContainer, 
TestSolr4Spatial, SolrCoreTest, StatsComponentTest, SolrCmdDistributorTest, 
PeerSyncTest, BadIndexSchemaTest, ConvertedLegacyTest, BasicFunctionalityTest, 
TestBadConfig, TestIndexSearcher, SoftAutoCommitTest, 
DistributedQueryElevationComponentTest, TestCoreDiscovery, 
SpellCheckCollatorTest, TestFoldingMultitermQuery, DocValuesTest, 
SuggesterTSTTest, SuggesterTest, TestTrie, SuggesterWFSTTest, TestCSVLoader, 
PolyFieldTest, SchemaVersionSpecificBehaviorTest, 
SolrCoreCheckLockOnStartupTest, TestPseudoReturnFields, TestUpdate, 
TestAtomicUpdateErrorCases, DirectUpdateHandlerOptimizeTest, 
DefaultValueUpdateProcessorTest, StatelessScriptUpdateProcessorFactoryTest, 
TestRemoteStreaming, DocValuesMultiTest, XsltUpdateRequestHandlerTest, 
CacheHeaderTest, TestQueryUtils, TestReversedWildcardFilterFactory, 
TestQueryTypes, PrimitiveFieldTypeTest, FileBasedSpellCheckerTest, 
TermsComponentTest, XmlUpdateRequestHandlerTest, RequestHandlersTest, 
TestValueSourceCache, PathHierarchyTokenizerFactoryTest, 
TermVectorComponentTest, TestIndexingPerformance, MoreLikeThisHandlerTest, 
TestSolrQueryParser, IndexSchemaRuntimeFieldTest, LoggingHandlerTest, 
TestCollationField, TestCSVResponseWriter, QueryParsingTest, 
TestAnalyzedSuggestions, UniqFieldsUpdateProcessorFactoryTest, JsonLoaderTest, 
TestPHPSerializedResponseWriter, PingRequestHandlerTest, TestComponentsName, 
SearchHandlerTest, HighlighterConfigTest, TestQuerySenderListener, 
UpdateParamsTest, AlternateDirectoryTest, TestQuerySenderNoQuery, 
TestStressRecovery, TestMergePolicyConfig, MultiTermTest, SampleTest, 
TestBinaryField, TestSearchPerf, MinimalSchemaTest, TestElisionMultitermQuery, 
TestConfig, ExternalFileFieldSortTest, TestSolrCoreProperties, 
TestLuceneMatchVersion, SpellPossibilityIteratorTest, SynonymTokenizerTest, 
TestXIncludeConfig, EchoParamsTest, TestDFRSimilarityFactory, 
TestIBSimilarityFactory, ResourceLoaderTest, ScriptEngineTest, 
OpenExchangeRatesOrgProviderTest, TestSuggestSpellingConverter, DOMUtilTest, 
ClusterStateTest, TestSolrJ, TestLRUCache, TestDocumentBuilder, 
ZkNodePropsTest, SliceStateTest, FileUtilsTest, CircularListTest, 
DistributedMLTComponentTest, SolrTestCaseJ4Test, TestHighlightDedupGrouping, 
TestEmbeddedSolrServerAdminHandler, TestEmbeddedSolrServerSchemaAPI, 
TestJettySolrRunner, ConnectionReuseTest, AddReplicaTest, AssignTest, 
ChaosMonkeyNothingIsSafeWithPullReplicasTest, CollectionsAPISolrJTest, 
CustomCollectionTest, DeleteShardTest, DeleteStatusTest, DistributedQueueTest, 
DocValuesNotIndexedTest, LeaderElectionContextKeyTest, 
LeaderInitiatedRecoveryOnShardRestartTest, LegacyCloudClusterPropTest, 
MigrateRouteKeyTest, OverriddenZkACLAndCredentialsProvidersTest, 
OverseerRolesTest, OverseerStatusTest, RemoteQueryErrorTest, SSLMigrationTest, 
SaslZkACLProviderTest, SolrCloudExampleTest, TestCloudPseudoReturnFields, 
TestCloudSearcherWarming, TestConfigSetsAPIZkFailure, 
TestDeleteCollectionOnDownNodes, TestExclusionRuleCollectionAccess, 
TestLockTree, TestOnReconnectListenerSupport, TestPullReplicaErrorHandling, 
TestSolrCloudWithDelegationTokens, TestSolrCloudWithKerberosAlt, 
TestSolrCloudWithSecureImpersonation, TestTlogReplica, 
AutoAddReplicasIntegrationTest, HdfsAutoAddReplicasIntegrationTest, 
HttpTriggerListenerTest, NodeAddedTriggerTest, TriggerIntegrationTest]
   [junit4] Completed [597/751 (2!)] on J0 in 160.94s, 13 tests, 1 failure <<< 
FAILURES!

[...truncated 40647 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to