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