You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2017/10/19 23:49:28 UTC
[JENKINS] Lucene-Solr-7.x-Windows (32bit/jdk1.8.0_144) - Build #
256 - Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Windows/256/
Java: 32bit/jdk1.8.0_144 -server -XX:+UseParallelGC
2 tests failed.
FAILED: org.apache.solr.cloud.autoscaling.ExecutePlanActionTest.testIntegration
Error Message:
Timed out waiting for replicas of collection to be 2 again null Live Nodes: [127.0.0.1:50449_solr] Last available state: DocCollection(testIntegration//collections/testIntegration/state.json/9)={ "pullReplicas":"0", "replicationFactor":"2", "shards":{"shard1":{ "range":"80000000-7fffffff", "state":"active", "replicas":{ "core_node3":{ "core":"testIntegration_shard1_replica_n1", "base_url":"http://127.0.0.1:50446/solr", "node_name":"127.0.0.1:50446_solr", "state":"down", "type":"NRT"}, "core_node4":{ "core":"testIntegration_shard1_replica_n2", "base_url":"http://127.0.0.1:50449/solr", "node_name":"127.0.0.1:50449_solr", "state":"active", "type":"NRT", "leader":"true"}}}}, "router":{"name":"compositeId"}, "maxShardsPerNode":"1", "autoAddReplicas":"false", "nrtReplicas":"2", "tlogReplicas":"0"}
Stack Trace:
java.lang.AssertionError: Timed out waiting for replicas of collection to be 2 again
null
Live Nodes: [127.0.0.1:50449_solr]
Last available state: DocCollection(testIntegration//collections/testIntegration/state.json/9)={
"pullReplicas":"0",
"replicationFactor":"2",
"shards":{"shard1":{
"range":"80000000-7fffffff",
"state":"active",
"replicas":{
"core_node3":{
"core":"testIntegration_shard1_replica_n1",
"base_url":"http://127.0.0.1:50446/solr",
"node_name":"127.0.0.1:50446_solr",
"state":"down",
"type":"NRT"},
"core_node4":{
"core":"testIntegration_shard1_replica_n2",
"base_url":"http://127.0.0.1:50449/solr",
"node_name":"127.0.0.1:50449_solr",
"state":"active",
"type":"NRT",
"leader":"true"}}}},
"router":{"name":"compositeId"},
"maxShardsPerNode":"1",
"autoAddReplicas":"false",
"nrtReplicas":"2",
"tlogReplicas":"0"}
at __randomizedtesting.SeedInfo.seed([2A801FA6D9FD7248:9AE1118AFCC2D36D]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.cloud.SolrCloudTestCase.waitForState(SolrCloudTestCase.java:269)
at org.apache.solr.cloud.autoscaling.ExecutePlanActionTest.testIntegration(ExecutePlanActionTest.java:209)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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 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.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigReplication
Error Message:
Index: 0, Size: 0
Stack Trace:
java.lang.IndexOutOfBoundsException: Index: 0, Size: 0
at __randomizedtesting.SeedInfo.seed([2A801FA6D9FD7248:3EC844F3FAFACF56]:0)
at java.util.ArrayList.rangeCheck(ArrayList.java:653)
at java.util.ArrayList.get(ArrayList.java:429)
at org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigReplication(TestReplicationHandler.java:561)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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 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.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 12361 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\init-core-data-001
[junit4] 2> 911547 INFO (SUITE-TestReplicationHandler-seed#[2A801FA6D9FD7248]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 911548 INFO (SUITE-TestReplicationHandler-seed#[2A801FA6D9FD7248]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None)
[junit4] 2> 911548 INFO (SUITE-TestReplicationHandler-seed#[2A801FA6D9FD7248]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 911550 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.SolrTestCaseJ4 ###Starting doTestReplicateAfterCoreReload
[junit4] 2> 911551 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-001\collection1
[junit4] 2> 911566 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 911567 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@16da33e{/solr,null,AVAILABLE}
[junit4] 2> 911568 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@c48fd{HTTP/1.1,[http/1.1]}{127.0.0.1:62635}
[junit4] 2> 911569 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.Server Started @919767ms
[junit4] 2> 911569 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-001\collection1\data, hostContext=/solr, hostPort=62635}
[junit4] 2> 911569 ERROR (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 911569 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.2.0
[junit4] 2> 911569 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 911569 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null
[junit4] 2> 911569 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-10-19T22:48:06.210Z
[junit4] 2> 911570 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-001\solr.xml
[junit4] 2> 911576 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 911576 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 911577 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 911663 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901
[junit4] 2> 911667 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901
[junit4] 2> 911668 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901
[junit4] 2> 911673 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-001\.
[junit4] 2> 911673 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 911673 INFO (coreLoadExecutor-5058-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 911702 INFO (coreLoadExecutor-5058-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
[junit4] 2> 911707 INFO (coreLoadExecutor-5058-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 911709 INFO (coreLoadExecutor-5058-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 911709 INFO (coreLoadExecutor-5058-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-001\.\collection1, trusted=true
[junit4] 2> 911710 INFO (coreLoadExecutor-5058-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901
[junit4] 2> 911710 INFO (coreLoadExecutor-5058-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 911710 INFO (coreLoadExecutor-5058-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-001\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-001\.\collection1\data\]
[junit4] 2> 911711 INFO (coreLoadExecutor-5058-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=11, maxMergeAtOnceExplicit=15, maxMergedSegmentMB=1.53515625, floorSegmentMB=2.029296875, forceMergeDeletesPctAllowed=20.729158897602986, segmentsPerTier=41.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.32723672226691614
[junit4] 2> 911780 INFO (coreLoadExecutor-5058-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 911780 INFO (coreLoadExecutor-5058-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 911780 INFO (coreLoadExecutor-5058-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=15, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6731256002184955]
[junit4] 2> 911781 INFO (coreLoadExecutor-5058-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1ea1cc4[collection1] main]
[junit4] 2> 911781 INFO (coreLoadExecutor-5058-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-001\collection1\conf
[junit4] 2> 911781 INFO (coreLoadExecutor-5058-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 911781 INFO (coreLoadExecutor-5058-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 911782 INFO (searcherExecutor-5059-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1ea1cc4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 911785 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-002\collection1
[junit4] 2> 911793 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 911794 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@d1639{/solr,null,AVAILABLE}
[junit4] 2> 911794 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1645c85{HTTP/1.1,[http/1.1]}{127.0.0.1:62638}
[junit4] 2> 911794 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.Server Started @919993ms
[junit4] 2> 911794 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-002\collection1\data, hostContext=/solr, hostPort=62638}
[junit4] 2> 911794 ERROR (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 911794 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.2.0
[junit4] 2> 911794 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 911794 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null
[junit4] 2> 911794 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-10-19T22:48:06.435Z
[junit4] 2> 911796 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-002\solr.xml
[junit4] 2> 911802 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 911802 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 911802 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 911865 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901
[junit4] 2> 911874 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901
[junit4] 2> 911874 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901
[junit4] 2> 911879 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-002\.
[junit4] 2> 911879 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 911879 INFO (coreLoadExecutor-5068-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 911904 INFO (coreLoadExecutor-5068-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
[junit4] 2> 911909 INFO (coreLoadExecutor-5068-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 911911 INFO (coreLoadExecutor-5068-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 911912 INFO (coreLoadExecutor-5068-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-002\.\collection1, trusted=true
[junit4] 2> 911912 INFO (coreLoadExecutor-5068-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901
[junit4] 2> 911912 INFO (coreLoadExecutor-5068-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 911912 INFO (coreLoadExecutor-5068-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-002\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-002\.\collection1\data\]
[junit4] 2> 911913 INFO (coreLoadExecutor-5068-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=11, maxMergeAtOnceExplicit=15, maxMergedSegmentMB=1.53515625, floorSegmentMB=2.029296875, forceMergeDeletesPctAllowed=20.729158897602986, segmentsPerTier=41.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.32723672226691614
[junit4] 2> 911974 INFO (coreLoadExecutor-5068-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 911974 INFO (coreLoadExecutor-5068-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 911975 INFO (coreLoadExecutor-5068-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=15, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6731256002184955]
[junit4] 2> 911976 INFO (coreLoadExecutor-5068-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@86c1a9[collection1] main]
[junit4] 2> 911976 INFO (coreLoadExecutor-5068-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-002\collection1\conf
[junit4] 2> 911979 INFO (coreLoadExecutor-5068-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 911979 INFO (coreLoadExecutor-5068-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 911979 INFO (searcherExecutor-5069-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@86c1a9[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 911981 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@1645c85{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 911981 INFO (qtp7839792-15197) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 911981 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=26964048
[junit4] 2> 911982 INFO (indexFetcher-5073-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 1
[junit4] 2> 911982 INFO (indexFetcher-5073-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's version: 0
[junit4] 2> 911982 INFO (indexFetcher-5073-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 911982 INFO (indexFetcher-5073-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Slave's version: 0
[junit4] 2> 911982 INFO (indexFetcher-5073-thread-1) [ x:collection1] o.a.s.h.IndexFetcher New index in Master. Deleting mine...
[junit4] 2> 911982 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 911982 INFO (indexFetcher-5073-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 911982 INFO (indexFetcher-5073-thread-1) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1729bfe commitCommandVersion:0
[junit4] 2> 911982 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@dd32f5: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@112c12b
[junit4] 2> 911983 INFO (indexFetcher-5073-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@7d4f0e[collection1] main]
[junit4] 2> 911983 INFO (indexFetcher-5073-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 911984 INFO (searcherExecutor-5069-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7d4f0e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 911987 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 911987 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@15b1410: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1eb9bf1
[junit4] 2> 911990 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 911990 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5c3e8f: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@c1311
[junit4] 2> 911991 INFO (coreCloseExecutor-5074-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@fcfe95
[junit4] 2> 911991 INFO (coreCloseExecutor-5074-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=16580245
[junit4] 2> 911991 INFO (coreCloseExecutor-5074-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@19c624b: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@1a5211b
[junit4] 2> 911997 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@d1639{/solr,null,UNAVAILABLE}
[junit4] 2> 911999 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@c48fd{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 911999 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=17185708
[junit4] 2> 911999 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 911999 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@101051c: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@3fc653
[junit4] 2> 912000 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 912000 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2d2d4c: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1eb9bf1
[junit4] 2> 912000 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 912000 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@66056a: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@c1311
[junit4] 2> 912001 INFO (coreCloseExecutor-5076-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@c81d88
[junit4] 2> 912001 INFO (coreCloseExecutor-5076-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=13114760
[junit4] 2> 912001 INFO (coreCloseExecutor-5076-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@23f27c: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@1c7c459
[junit4] 2> 912003 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@16da33e{/solr,null,UNAVAILABLE}
[junit4] 2> 912006 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 912007 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@19ba06b{/solr,null,AVAILABLE}
[junit4] 2> 912007 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1aaa25e{HTTP/1.1,[http/1.1]}{127.0.0.1:62642}
[junit4] 2> 912008 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.Server Started @920206ms
[junit4] 2> 912008 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-001\collection1\data, hostContext=/solr, hostPort=62642}
[junit4] 2> 912008 ERROR (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 912008 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.2.0
[junit4] 2> 912008 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 912008 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null
[junit4] 2> 912008 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-10-19T22:48:06.649Z
[junit4] 2> 912009 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-001\solr.xml
[junit4] 2> 912015 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 912015 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 912015 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 912074 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901
[junit4] 2> 912080 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901
[junit4] 2> 912080 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901
[junit4] 2> 912082 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-001\.
[junit4] 2> 912082 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 912082 INFO (coreLoadExecutor-5083-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 912117 INFO (coreLoadExecutor-5083-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
[junit4] 2> 912123 INFO (coreLoadExecutor-5083-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 912125 INFO (coreLoadExecutor-5083-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 912125 INFO (coreLoadExecutor-5083-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-001\.\collection1, trusted=true
[junit4] 2> 912126 INFO (coreLoadExecutor-5083-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901
[junit4] 2> 912126 INFO (coreLoadExecutor-5083-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 912126 INFO (coreLoadExecutor-5083-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-001\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-001\.\collection1\data\]
[junit4] 2> 912127 INFO (coreLoadExecutor-5083-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=11, maxMergeAtOnceExplicit=15, maxMergedSegmentMB=1.53515625, floorSegmentMB=2.029296875, forceMergeDeletesPctAllowed=20.729158897602986, segmentsPerTier=41.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.32723672226691614
[junit4] 2> 912186 INFO (coreLoadExecutor-5083-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 912186 INFO (coreLoadExecutor-5083-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 912186 INFO (coreLoadExecutor-5083-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=15, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6731256002184955]
[junit4] 2> 912186 INFO (coreLoadExecutor-5083-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3717e4[collection1] main]
[junit4] 2> 912186 INFO (coreLoadExecutor-5083-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-001\collection1\conf
[junit4] 2> 912188 INFO (coreLoadExecutor-5083-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml
[junit4] 2> 912188 INFO (coreLoadExecutor-5083-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 912188 INFO (searcherExecutor-5084-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3717e4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 912190 INFO (qtp30065537-15239) [ x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 912190 INFO (qtp30065537-15239) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{deleteByQuery=*:*} 0 0
[junit4] 2> 912190 INFO (qtp30065537-15241) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 912190 INFO (qtp30065537-15241) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1d5d525 commitCommandVersion:0
[junit4] 2> 912194 INFO (qtp30065537-15241) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2f3f54[collection1] main]
[junit4] 2> 912194 INFO (qtp30065537-15241) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 912195 INFO (searcherExecutor-5084-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2f3f54[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 912195 INFO (qtp30065537-15241) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 2
[junit4] 2> 912196 INFO (qtp30065537-15240) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 912196 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 0 docs
[junit4] 2> 912198 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 912199 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2a6e58{/solr,null,AVAILABLE}
[junit4] 2> 912200 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@120fc7c{HTTP/1.1,[http/1.1]}{127.0.0.1:62646}
[junit4] 2> 912200 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.Server Started @920399ms
[junit4] 2> 912200 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-002\collection1\data, hostContext=/solr, hostPort=62646}
[junit4] 2> 912200 ERROR (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 912201 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.2.0
[junit4] 2> 912201 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 912201 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null
[junit4] 2> 912201 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-10-19T22:48:06.842Z
[junit4] 2> 912201 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-002\solr.xml
[junit4] 2> 912207 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 912207 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 912208 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 912282 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901
[junit4] 2> 912286 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901
[junit4] 2> 912286 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901
[junit4] 2> 912291 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-002\.
[junit4] 2> 912291 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 912291 INFO (coreLoadExecutor-5093-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 912320 INFO (coreLoadExecutor-5093-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
[junit4] 2> 912325 INFO (coreLoadExecutor-5093-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 912328 INFO (coreLoadExecutor-5093-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 912328 INFO (coreLoadExecutor-5093-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-002\.\collection1, trusted=true
[junit4] 2> 912328 INFO (coreLoadExecutor-5093-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901
[junit4] 2> 912328 INFO (coreLoadExecutor-5093-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 912328 INFO (coreLoadExecutor-5093-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-002\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-002\.\collection1\data\]
[junit4] 2> 912330 INFO (coreLoadExecutor-5093-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=11, maxMergeAtOnceExplicit=15, maxMergedSegmentMB=1.53515625, floorSegmentMB=2.029296875, forceMergeDeletesPctAllowed=20.729158897602986, segmentsPerTier=41.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.32723672226691614
[junit4] 2> 912411 INFO (coreLoadExecutor-5093-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 912411 INFO (coreLoadExecutor-5093-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 912412 INFO (coreLoadExecutor-5093-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=15, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6731256002184955]
[junit4] 2> 912412 INFO (coreLoadExecutor-5093-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1c7eb04[collection1] main]
[junit4] 2> 912412 INFO (coreLoadExecutor-5093-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-002\collection1\conf
[junit4] 2> 912416 INFO (coreLoadExecutor-5093-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 912416 INFO (coreLoadExecutor-5093-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 912417 INFO (searcherExecutor-5094-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1c7eb04[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 912417 INFO (qtp12874844-15257) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 912417 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 0 docs
[junit4] 2> 912417 INFO (qtp30065537-15242) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getIndexVersion&qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 912417 INFO (qtp30065537-15243) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getCommits&qt=/replication&wt=javabin&version=2&command=commits} status=0 QTime=0
[junit4] 2> 912450 INFO (qtp30065537-15237) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
[junit4] 2> 912460 INFO (qtp30065537-15237) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 912464 INFO (qtp30065537-15237) [ ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 912464 INFO (qtp30065537-15237) [ ] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-001\.\collection1
[junit4] 2> 912484 INFO (qtp30065537-15237) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901
[junit4] 2> 912484 INFO (qtp30065537-15237) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-001\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-001\.\collection1\data\]
[junit4] 2> 912551 INFO (qtp30065537-15237) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 912552 INFO (qtp30065537-15237) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 912553 INFO (qtp30065537-15237) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1f0ec7d[collection1] main]
[junit4] 2> 912553 INFO (qtp30065537-15237) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-001\collection1\conf
[junit4] 2> 912554 INFO (qtp30065537-15237) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml
[junit4] 2> 912554 INFO (qtp30065537-15237) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 912555 INFO (qtp30065537-15237) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=31, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 912555 INFO (qtp30065537-15237) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 912555 INFO (searcherExecutor-5099-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1f0ec7d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 912555 INFO (qtp30065537-15237) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@123b9ef[collection1] main]
[junit4] 2> 912556 INFO (qtp30065537-15237) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@abbcaa
[junit4] 2> 912556 INFO (qtp30065537-15237) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=11254954
[junit4] 2> 912556 INFO (qtp30065537-15237) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@13770be: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@1458683
[junit4] 2> 912556 INFO (searcherExecutor-5099-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@123b9ef[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 912561 INFO (qtp30065537-15237) [ x:collection1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={core=collection1&qt=/admin/cores&action=reload&wt=javabin&version=2} status=0 QTime=137
[junit4] 2> 912562 INFO (qtp30065537-15239) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getIndexVersion&qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 912562 INFO (qtp30065537-15240) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getCommits&qt=/replication&wt=javabin&version=2&command=commits} status=0 QTime=0
[junit4] 2> 912563 INFO (qtp30065537-15242) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[10]} 0 0
[junit4] 2> 912564 INFO (qtp30065537-15243) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[20]} 0 0
[junit4] 2> 912564 INFO (qtp30065537-15244) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 912564 INFO (qtp30065537-15244) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@f1b9d1 commitCommandVersion:0
[junit4] 2> 912565 INFO (qtp30065537-15244) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@e90218[collection1] main]
[junit4] 2> 912566 INFO (qtp30065537-15244) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 912566 INFO (searcherExecutor-5099-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@e90218[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):c2)))}
[junit4] 2> 912567 INFO (qtp30065537-15244) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 2
[junit4] 2> 912567 INFO (qtp30065537-15237) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=2 status=0 QTime=0
[junit4] 2> 912568 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 2 docs
[junit4] 2> 912568 INFO (qtp12874844-15258) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 912568 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.h.TestReplicationHandler Waiting for 2 docs
[junit4] 2> 912580 INFO (qtp30065537-15239) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 912580 INFO (indexFetcher-5098-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 3
[junit4] 2> 912580 INFO (indexFetcher-5098-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's version: 1508453287205
[junit4] 2> 912580 INFO (indexFetcher-5098-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 912580 INFO (indexFetcher-5098-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Slave's version: 0
[junit4] 2> 912580 INFO (indexFetcher-5098-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 912584 INFO (qtp30065537-15240) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&wt=javabin&version=2&command=filelist} status=0 QTime=3
[junit4] 2> 912585 INFO (indexFetcher-5098-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 4
[junit4] 2> 912585 INFO (indexFetcher-5098-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=32, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 912586 INFO (indexFetcher-5098-thread-1) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 912586 INFO (indexFetcher-5098-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MockDirectoryWrapper(RAMDirectory@11e3404 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1dd0ebf)
[junit4] 2> 912586 INFO (qtp30065537-15242) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0.cfe&checksum=true&compression=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 912587 INFO (qtp30065537-15243) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0.si&checksum=true&compression=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 912589 INFO (qtp30065537-15244) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0.cfs&checksum=true&compression=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 912589 INFO (qtp30065537-15237) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=segments_3&checksum=true&compression=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 912589 INFO (indexFetcher-5098-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=1956) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@11e3404 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1dd0ebf)
[junit4] 2> 912591 INFO (indexFetcher-5098-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=69.0966796875, floorSegmentMB=1.126953125, forceMergeDeletesPctAllowed=17.95751589885553, segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5655667948709506
[junit4] 2> 912592 INFO (indexFetcher-5098-thread-1) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 912592 INFO (indexFetcher-5098-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1cca1e4[collection1] main]
[junit4] 2> 912593 INFO (searcherExecutor-5094-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1cca1e4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):c2)))}
[junit4] 2> 912669 INFO (qtp12874844-15260) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=2 status=0 QTime=0
[junit4] 2> 912670 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.h.TestReplicationHandler Waited for 100ms and found 2 docs
[junit4] 2> 912670 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.SolrTestCaseJ4 ###Ending doTestReplicateAfterCoreReload
[junit4] 2> 912670 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@1aaa25e{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 912671 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=3604882
[junit4] 2> 912671 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 912671 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@155eaa2: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@1efcd43
[junit4] 2> 912673 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 912673 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1b85960: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1eb9bf1
[junit4] 2> 912676 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 912676 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@594144: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@c1311
[junit4] 2> 912676 INFO (coreCloseExecutor-5104-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@76e147
[junit4] 2> 912676 INFO (coreCloseExecutor-5104-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=7790919
[junit4] 2> 912676 INFO (coreCloseExecutor-5104-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@194290d: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@1458683
[junit4] 2> 912683 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@19ba06b{/solr,null,UNAVAILABLE}
[junit4] 2> 912685 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@120fc7c{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 912685 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=32700371
[junit4] 2> 912685 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 912685 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1e9d894: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@5fae78
[junit4] 2> 912690 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 912690 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1fd3d88: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1eb9bf1
[junit4] 2> 912693 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 912693 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@537f3d: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@c1311
[junit4] 2> 912694 INFO (coreCloseExecutor-5106-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1930b6d
[junit4] 2> 912694 INFO (coreCloseExecutor-5106-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=26413933
[junit4] 2> 912694 INFO (coreCloseExecutor-5106-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4cef0a: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@1896acf
[junit4] 2> 912694 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2a6e58{/solr,null,UNAVAILABLE}
[junit4] IGNOR/A 0.00s J0 | TestReplicationHandler.doTestIndexFetchOnMasterRestart
[junit4] > Assumption #1: 'awaitsfix' test group is disabled (@AwaitsFix(bugUrl=https://issues.apache.org/jira/browse/SOLR-9036))
[junit4] 2> 912701 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.SolrTestCaseJ4 ###Starting doTestReplicateAfterStartupWithNoActivity
[junit4] 2> 912704 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-003\collection1
[junit4] 2> 912715 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 912715 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1fcce4d{/solr,null,AVAILABLE}
[junit4] 2> 912717 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1824253{HTTP/1.1,[http/1.1]}{127.0.0.1:62652}
[junit4] 2> 912717 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.Server Started @920915ms
[junit4] 2> 912717 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-003\collection1\data, hostContext=/solr, hostPort=62652}
[junit4] 2> 912718 ERROR (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 912718 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.2.0
[junit4] 2> 912718 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 912718 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null
[junit4] 2> 912718 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-10-19T22:48:07.359Z
[junit4] 2> 912719 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-003\solr.xml
[junit4] 2> 912728 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 912728 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 912729 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 912814 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901
[junit4] 2> 912821 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901
[junit4] 2> 912821 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901
[junit4] 2> 912825 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-003\.
[junit4] 2> 912825 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 912826 INFO (coreLoadExecutor-5113-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 912849 INFO (coreLoadExecutor-5113-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
[junit4] 2> 912861 INFO (coreLoadExecutor-5113-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 912864 INFO (coreLoadExecutor-5113-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 912864 INFO (coreLoadExecutor-5113-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-003\.\collection1, trusted=true
[junit4] 2> 912864 INFO (coreLoadExecutor-5113-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901
[junit4] 2> 912865 INFO (coreLoadExecutor-5113-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 912865 INFO (coreLoadExecutor-5113-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-003\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-003\.\collection1\data\]
[junit4] 2> 912866 INFO (coreLoadExecutor-5113-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=11, maxMergeAtOnceExplicit=15, maxMergedSegmentMB=1.53515625, floorSegmentMB=2.029296875, forceMergeDeletesPctAllowed=20.729158897602986, segmentsPerTier=41.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.32723672226691614
[junit4] 2> 912975 INFO (coreLoadExecutor-5113-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 912975 INFO (coreLoadExecutor-5113-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 912976 INFO (coreLoadExecutor-5113-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=15, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6731256002184955]
[junit4] 2> 912976 INFO (coreLoadExecutor-5113-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1c25818[collection1] main]
[junit4] 2> 912977 INFO (coreLoadExecutor-5113-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-003\collection1\conf
[junit4] 2> 912977 INFO (coreLoadExecutor-5113-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 912977 INFO (coreLoadExecutor-5113-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 912978 INFO (searcherExecutor-5114-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1c25818[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 912982 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-004\collection1
[junit4] 2> 912998 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 912998 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@8e350f{/solr,null,AVAILABLE}
[junit4] 2> 913000 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1ff4a1b{HTTP/1.1,[http/1.1]}{127.0.0.1:62655}
[junit4] 2> 913000 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.e.j.s.Server Started @921199ms
[junit4] 2> 913000 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-004\collection1\data, hostContext=/solr, hostPort=62655}
[junit4] 2> 913000 ERROR (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 913000 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.2.0
[junit4] 2> 913000 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 913000 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null
[junit4] 2> 913000 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-10-19T22:48:07.641Z
[junit4] 2> 913001 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_2A801FA6D9FD7248-001\solr-instance-004\solr.xml
[junit4] 2> 913011 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 913011 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 913011 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 913102 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[2A801FA6D9FD7248]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@121b901
[junit4] 2> 913114 INFO (TEST-TestReplicatio
[...truncated too long message...]
4] 2> at org.apache.solr.client.solrj.impl.SolrClientCloudManager.request(SolrClientCloudManager.java:99)
[junit4] 2> ... 9 more
[junit4] 2> 2068331 ERROR (AutoscalingActionExecutor-7201-thread-1-processing-n:127.0.0.1:50449_solr) [n:127.0.0.1:50449_solr ] o.a.s.c.a.ExecutePlanAction Unexpected Exception while querying status of requestId=node_lost_trigger/14ef1ac56d0f3c40T2ulrb4idj4efy1arx7phz9bwq/0
[junit4] 2> java.io.IOException: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request
[junit4] 2> at org.apache.solr.client.solrj.impl.SolrClientCloudManager.request(SolrClientCloudManager.java:101)
[junit4] 2> at org.apache.solr.cloud.autoscaling.ExecutePlanAction.waitForTaskToFinish(ExecutePlanAction.java:130)
[junit4] 2> at org.apache.solr.cloud.autoscaling.ScheduledTriggers.waitForPendingTasks(ScheduledTriggers.java:289)
[junit4] 2> at org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$null$2(ScheduledTriggers.java:221)
[junit4] 2> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> Caused by: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request
[junit4] 2> at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:460)
[junit4] 2> at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1086)
[junit4] 2> at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:867)
[junit4] 2> at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:800)
[junit4] 2> at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:178)
[junit4] 2> at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:195)
[junit4] 2> at org.apache.solr.client.solrj.impl.SolrClientCloudManager.request(SolrClientCloudManager.java:99)
[junit4] 2> ... 9 more
[junit4] 2> 2073036 WARN (OverseerThreadFactory-7202-thread-1-processing-n:127.0.0.1:50449_solr) [n:127.0.0.1:50449_solr ] o.a.s.c.MoveReplicaCmd Timed out waiting for leader's replica to recover, collection=testExecute shard=shard1 on node=127.0.0.1:50449_solr
[junit4] 2> 2073039 INFO (OverseerThreadFactory-7202-thread-1-processing-n:127.0.0.1:50449_solr) [n:127.0.0.1:50449_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000006 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 2073039 WARN (OverseerAutoScalingTriggerThread-98858029401767942-127.0.0.1:50449_solr-n_0000000001) [n:127.0.0.1:50449_solr ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 2073039 DEBUG (jetty-closer-5189-thread-1) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
[junit4] 2> 2073039 INFO (jetty-closer-5189-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1304fae{/solr,null,UNAVAILABLE}
[junit4] 2> 2073044 ERROR (SUITE-ExecutePlanActionTest-seed#[2A801FA6D9FD7248]-worker) [ ] 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> 2073045 INFO (SUITE-ExecutePlanActionTest-seed#[2A801FA6D9FD7248]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:50442 50442
[junit4] 2> 2073045 INFO (Thread-3410) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:50442 50442
[junit4] 2> 2073046 WARN (Thread-3410) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 4 /solr/aliases.json
[junit4] 2> 4 /solr/clusterprops.json
[junit4] 2> 3 /solr/configs/conf
[junit4] 2> 2 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 23 /solr/collections/testIntegration/state.json
[junit4] 2> 20 /solr/collections/testExecute/state.json
[junit4] 2> 4 /solr/clusterstate.json
[junit4] 2> 2 /solr/autoscaling.json
[junit4] 2> 2 /solr/collections/testExecute/leader_elect/shard1/election/98858029401767941-core_node4-n_0000000000
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 4 /solr/live_nodes
[junit4] 2> 4 /solr/collections
[junit4] 2> 2 /solr/overseer/queue
[junit4] 2> 2 /solr/autoscaling/events/.auto_add_replicas
[junit4] 2> 2 /solr/autoscaling/events/node_lost_trigger
[junit4] 2> 2 /solr/overseer/queue-work
[junit4] 2> 2 /solr/overseer/collection-queue-work
[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.ExecutePlanActionTest_2A801FA6D9FD7248-001
[junit4] 2> Oct 19, 2017 11:07:27 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 2 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=FastCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST, chunkSize=4, maxDocsPerChunk=10, blockSize=5), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST, chunkSize=4, blockSize=5)), sim=RandomSimilarity(queryNorm=true): {}, locale=und, timezone=America/Dawson_Creek
[junit4] 2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_144 (32-bit)/cpus=3,threads=1,free=221845256,total=517210112
[junit4] 2> NOTE: All tests run in this JVM: [TestCloudNestedDocsSort, HighlighterTest, TestMultiWordSynonyms, TestInitQParser, TestXmlQParser, TestFieldResource, AddSchemaFieldsUpdateProcessorFactoryTest, OverseerTaskQueueTest, AddReplicaTest, ScriptEngineTest, TestSolr4Spatial2, TestUtils, TestPseudoReturnFields, TestTolerantSearch, SuggesterTSTTest, TestBinaryField, MissingSegmentRecoveryTest, DistributedVersionInfoTest, CollectionTooManyReplicasTest, JavabinLoaderTest, DistributedFacetPivotLargeTest, TestReloadDeadlock, BasicAuthStandaloneTest, TestIBSimilarityFactory, TestPullReplica, ZkCLITest, TestPayloadScoreQParserPlugin, TestSystemCollAutoCreate, TestExpandComponent, SignatureUpdateProcessorFactoryTest, SuggestComponentTest, BitVectorTest, TestCSVResponseWriter, SuggesterFSTTest, PrimUtilsTest, TestGeoJSONResponseWriter, LeaderInitiatedRecoveryOnShardRestartTest, TestFieldCacheSortRandom, TestJsonRequest, VMParamsZkACLAndCredentialsProvidersTest, EnumFieldTest, TestPivotHelperCode, UpdateLogTest, SolrRequestParserTest, TestXIncludeConfig, SolrJmxReporterCloudTest, BigEndianAscendingWordDeserializerTest, BadIndexSchemaTest, CreateCollectionCleanupTest, OverseerRolesTest, TestSolrFieldCacheBean, CheckHdfsIndexTest, TestCloudPivotFacet, TestDefaultStatsCache, TestTolerantUpdateProcessorCloud, ResponseLogComponentTest, RequestHandlersTest, UnloadDistributedZkTest, SolrIndexMetricsTest, TestDFRSimilarityFactory, OutputWriterTest, TestUninvertingReader, TestCollapseQParserPlugin, TestStressLiveNodes, AlternateDirectoryTest, TestComplexPhraseQParserPlugin, BadCopyFieldTest, TestAnalyzeInfixSuggestions, SliceStateTest, DistributedSpellCheckComponentTest, TestLazyCores, TestStressCloudBlindAtomicUpdates, DistanceUnitsTest, TestCustomDocTransformer, JvmMetricsTest, MinimalSchemaTest, TestSolrConfigHandler, CollectionReloadTest, SolrCoreMetricManagerTest, TestManagedSchemaThreadSafety, UUIDFieldTest, AutoAddReplicasIntegrationTest, TestDocTermOrds, TestLFUCache, BlockDirectoryTest, TestDistribDocBasedVersion, DistribJoinFromCollectionTest, CloneFieldUpdateProcessorFactoryTest, NodeLostTriggerTest, TestReRankQParserPlugin, TestSolrConfigHandlerCloud, TestRetrieveFieldsOptimizer, TestNumericTerms32, FullHLLTest, SimpleCollectionCreateDeleteTest, TimeZoneUtilsTest, ClusterStateUpdateTest, SolrTestCaseJ4Test, TestOverriddenPrefixQueryForCustomFieldType, CircularListTest, CSVRequestHandlerTest, TestSQLHandler, LeaderFailureAfterFreshStartTest, SolrCmdDistributorTest, TestRebalanceLeaders, TestFieldCacheReopen, TestDFISimilarityFactory, UninvertDocValuesMergePolicyTest, URLClassifyProcessorTest, TestStreamBody, TestHighFrequencyDictionaryFactory, TestAuthorizationFramework, OverseerCollectionConfigSetProcessorTest, AnalysisErrorHandlingTest, XmlUpdateRequestHandlerTest, AsyncCallRequestStatusResponseTest, CdcrBootstrapTest, TestStressRecovery, TestJoin, OutOfBoxZkACLAndCredentialsProvidersTest, TestReplicationHandler, TestMacros, AutoScalingHandlerTest, TestCoreDiscovery, DateMathParserTest, RegexBoostProcessorTest, TestRandomCollapseQParserPlugin, SpellCheckCollatorTest, TestFieldSortValues, ConjunctionSolrSpellCheckerTest, TestSchemaResource, SecurityConfHandlerTest, TestSolr4Spatial, ShardSplitTest, RequestLoggingTest, TestClusterStateMutator, TestRuleBasedAuthorizationPlugin, TestDistributedSearch, DistribCursorPagingTest, UniqFieldsUpdateProcessorFactoryTest, XsltUpdateRequestHandlerTest, TestCollationFieldDocValues, SyncSliceTest, CursorPagingTest, ExecutePlanActionTest]
[junit4] Completed [461/744 (2!)] on J0 in 630.44s, 2 tests, 1 failure <<< FAILURES!
[...truncated 44014 lines...]
[JENKINS] Lucene-Solr-7.x-Windows (32bit/jdk1.8.0_144) - Build #
257 - Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Windows/257/
Java: 32bit/jdk1.8.0_144 -server -XX:+UseParallelGC
5 tests failed.
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([8D8C5AFB8278C078:443918558B1F068D]: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:684)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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 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.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.core.TestJmxIntegration.testJmxRegistration
Error Message:
org.apache.lucene.store.AlreadyClosedException: this IndexReader is closed
Stack Trace:
javax.management.RuntimeMBeanException: org.apache.lucene.store.AlreadyClosedException: this IndexReader is closed
at __randomizedtesting.SeedInfo.seed([8D8C5AFB8278C078:35D3EC1EF39981D]:0)
at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.rethrow(DefaultMBeanServerInterceptor.java:839)
at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.rethrowMaybeMBeanException(DefaultMBeanServerInterceptor.java:852)
at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getAttribute(DefaultMBeanServerInterceptor.java:651)
at com.sun.jmx.mbeanserver.JmxMBeanServer.getAttribute(JmxMBeanServer.java:678)
at org.apache.solr.core.TestJmxIntegration.testJmxRegistration(TestJmxIntegration.java:124)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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 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.lang.Thread.run(Thread.java:748)
Caused by: org.apache.lucene.store.AlreadyClosedException: this IndexReader is closed
at org.apache.lucene.index.IndexReader.ensureOpen(IndexReader.java:268)
at org.apache.lucene.index.StandardDirectoryReader.getVersion(StandardDirectoryReader.java:338)
at org.apache.lucene.index.FilterDirectoryReader.getVersion(FilterDirectoryReader.java:119)
at org.apache.lucene.index.FilterDirectoryReader.getVersion(FilterDirectoryReader.java:119)
at org.apache.solr.search.SolrIndexSearcher.lambda$initializeMetrics$14(SolrIndexSearcher.java:2254)
at org.apache.solr.metrics.reporters.jmx.JmxMetricsReporter$JmxGauge.getValue(JmxMetricsReporter.java:209)
at sun.reflect.GeneratedMethodAccessor118.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at sun.reflect.misc.Trampoline.invoke(MethodUtil.java:71)
at sun.reflect.GeneratedMethodAccessor2.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at sun.reflect.misc.MethodUtil.invoke(MethodUtil.java:275)
at com.sun.jmx.mbeanserver.StandardMBeanIntrospector.invokeM2(StandardMBeanIntrospector.java:112)
at com.sun.jmx.mbeanserver.StandardMBeanIntrospector.invokeM2(StandardMBeanIntrospector.java:46)
at com.sun.jmx.mbeanserver.MBeanIntrospector.invokeM(MBeanIntrospector.java:237)
at com.sun.jmx.mbeanserver.PerInterface.getAttribute(PerInterface.java:83)
at com.sun.jmx.mbeanserver.MBeanSupport.getAttribute(MBeanSupport.java:206)
at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getAttribute(DefaultMBeanServerInterceptor.java:647)
... 41 more
FAILED: junit.framework.TestSuite.org.apache.solr.util.TestSolrCLIRunExample
Error Message:
ObjectTracker found 5 object(s) that were not released!!! [NRTCachingDirectory, MDCAwareThreadPoolExecutor, TransactionLog, NRTCachingDirectory, NRTCachingDirectory] org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.NRTCachingDirectory at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.core.SolrCore.getNewIndexDir(SolrCore.java:350) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:710) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:935) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:844) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1036) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:948) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:91) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:384) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:389) at org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177) at org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:735) at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:716) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:497) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:426) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134) at org.eclipse.jetty.server.Server.handle(Server.java:534) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320) at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251) at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283) at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108) at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671) at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:873) at org.apache.solr.core.SolrCore.reload(SolrCore.java:637) at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1284) at org.apache.solr.core.SolrCore.lambda$getConfListener$20(SolrCore.java:2950) at org.apache.solr.cloud.ZkController.lambda$fireEventListeners$5(ZkController.java:2561) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.update.TransactionLog at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.update.TransactionLog.<init>(TransactionLog.java:190) at org.apache.solr.update.UpdateLog.newTransactionLog(UpdateLog.java:448) at org.apache.solr.update.UpdateLog.ensureLog(UpdateLog.java:1261) at org.apache.solr.update.UpdateLog.add(UpdateLog.java:534) at org.apache.solr.update.UpdateLog.add(UpdateLog.java:519) at org.apache.solr.update.DirectUpdateHandler2.doNormalUpdate(DirectUpdateHandler2.java:352) at org.apache.solr.update.DirectUpdateHandler2.addDoc0(DirectUpdateHandler2.java:271) at org.apache.solr.update.DirectUpdateHandler2.addDoc(DirectUpdateHandler2.java:221) at org.apache.solr.update.processor.RunUpdateProcessor.processAdd(RunUpdateProcessorFactory.java:67) at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55) at org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalAdd(DistributedUpdateProcessor.java:977) at org.apache.solr.update.processor.DistributedUpdateProcessor.versionAdd(DistributedUpdateProcessor.java:1193) at org.apache.solr.update.processor.DistributedUpdateProcessor.processAdd(DistributedUpdateProcessor.java:745) at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55) at org.apache.solr.update.processor.AddSchemaFieldsUpdateProcessorFactory$AddSchemaFieldsUpdateProcessor.processAdd(AddSchemaFieldsUpdateProcessorFactory.java:475) at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55) at org.apache.solr.update.processor.FieldMutatingUpdateProcessor.processAdd(FieldMutatingUpdateProcessor.java:118) at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55) at org.apache.solr.update.processor.FieldMutatingUpdateProcessor.processAdd(FieldMutatingUpdateProcessor.java:118) at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55) at org.apache.solr.update.processor.FieldMutatingUpdateProcessor.processAdd(FieldMutatingUpdateProcessor.java:118) at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55) at org.apache.solr.update.processor.FieldMutatingUpdateProcessor.processAdd(FieldMutatingUpdateProcessor.java:118) at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55) at org.apache.solr.update.processor.FieldNameMutatingUpdateProcessorFactory$1.processAdd(FieldNameMutatingUpdateProcessorFactory.java:75) at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55) at org.apache.solr.update.processor.FieldMutatingUpdateProcessor.processAdd(FieldMutatingUpdateProcessor.java:118) at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55) at org.apache.solr.update.processor.AbstractDefaultValueUpdateProcessorFactory$DefaultValueUpdateProcessor.processAdd(AbstractDefaultValueUpdateProcessorFactory.java:92) at org.apache.solr.handler.loader.JavabinLoader$1.update(JavabinLoader.java:98) at org.apache.solr.client.solrj.request.JavaBinUpdateRequestCodec$1.readOuterMostDocIterator(JavaBinUpdateRequestCodec.java:188) at org.apache.solr.client.solrj.request.JavaBinUpdateRequestCodec$1.readIterator(JavaBinUpdateRequestCodec.java:144) at org.apache.solr.common.util.JavaBinCodec.readObject(JavaBinCodec.java:311) at org.apache.solr.common.util.JavaBinCodec.readVal(JavaBinCodec.java:256) at org.apache.solr.client.solrj.request.JavaBinUpdateRequestCodec$1.readNamedList(JavaBinUpdateRequestCodec.java:130) at org.apache.solr.common.util.JavaBinCodec.readObject(JavaBinCodec.java:276) at org.apache.solr.common.util.JavaBinCodec.readVal(JavaBinCodec.java:256) at org.apache.solr.common.util.JavaBinCodec.unmarshal(JavaBinCodec.java:178) at org.apache.solr.client.solrj.request.JavaBinUpdateRequestCodec.unmarshal(JavaBinUpdateRequestCodec.java:195) at org.apache.solr.handler.loader.JavabinLoader.parseAndLoadDocs(JavabinLoader.java:108) at org.apache.solr.handler.loader.JavabinLoader.load(JavabinLoader.java:55) at org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:97) at org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:68) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177) at org.apache.solr.core.SolrCore.execute(SolrCore.java:2484) at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:710) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:516) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:426) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134) at org.eclipse.jetty.server.Server.handle(Server.java:534) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320) at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251) at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283) at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108) at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671) at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.NRTCachingDirectory at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:92) at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:742) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:935) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:844) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1036) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:948) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:91) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:384) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:389) at org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177) at org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:735) at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:716) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:497) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:426) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134) at org.eclipse.jetty.server.Server.handle(Server.java:534) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320) at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251) at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283) at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108) at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671) at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589) at java.lang.Thread.run(Thread.java:748) org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.NRTCachingDirectory at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:479) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:929) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:844) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1036) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:948) at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:91) at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:384) at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:389) at org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177) at org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:735) at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:716) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:497) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:426) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134) at org.eclipse.jetty.server.Server.handle(Server.java:534) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320) at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251) at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283) at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108) at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671) at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589) at java.lang.Thread.run(Thread.java:748)
Stack Trace:
java.lang.AssertionError: ObjectTracker found 5 object(s) that were not released!!! [NRTCachingDirectory, MDCAwareThreadPoolExecutor, TransactionLog, NRTCachingDirectory, NRTCachingDirectory]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.NRTCachingDirectory
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at org.apache.solr.core.SolrCore.getNewIndexDir(SolrCore.java:350)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:710)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:935)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:844)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1036)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:948)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:91)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:384)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:389)
at org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174)
at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177)
at org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:735)
at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:716)
at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:497)
at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382)
at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:426)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
at org.eclipse.jetty.server.Server.handle(Server.java:534)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108)
at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:873)
at org.apache.solr.core.SolrCore.reload(SolrCore.java:637)
at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1284)
at org.apache.solr.core.SolrCore.lambda$getConfListener$20(SolrCore.java:2950)
at org.apache.solr.cloud.ZkController.lambda$fireEventListeners$5(ZkController.java:2561)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.solr.update.TransactionLog
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.update.TransactionLog.<init>(TransactionLog.java:190)
at org.apache.solr.update.UpdateLog.newTransactionLog(UpdateLog.java:448)
at org.apache.solr.update.UpdateLog.ensureLog(UpdateLog.java:1261)
at org.apache.solr.update.UpdateLog.add(UpdateLog.java:534)
at org.apache.solr.update.UpdateLog.add(UpdateLog.java:519)
at org.apache.solr.update.DirectUpdateHandler2.doNormalUpdate(DirectUpdateHandler2.java:352)
at org.apache.solr.update.DirectUpdateHandler2.addDoc0(DirectUpdateHandler2.java:271)
at org.apache.solr.update.DirectUpdateHandler2.addDoc(DirectUpdateHandler2.java:221)
at org.apache.solr.update.processor.RunUpdateProcessor.processAdd(RunUpdateProcessorFactory.java:67)
at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
at org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalAdd(DistributedUpdateProcessor.java:977)
at org.apache.solr.update.processor.DistributedUpdateProcessor.versionAdd(DistributedUpdateProcessor.java:1193)
at org.apache.solr.update.processor.DistributedUpdateProcessor.processAdd(DistributedUpdateProcessor.java:745)
at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
at org.apache.solr.update.processor.AddSchemaFieldsUpdateProcessorFactory$AddSchemaFieldsUpdateProcessor.processAdd(AddSchemaFieldsUpdateProcessorFactory.java:475)
at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
at org.apache.solr.update.processor.FieldMutatingUpdateProcessor.processAdd(FieldMutatingUpdateProcessor.java:118)
at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
at org.apache.solr.update.processor.FieldMutatingUpdateProcessor.processAdd(FieldMutatingUpdateProcessor.java:118)
at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
at org.apache.solr.update.processor.FieldMutatingUpdateProcessor.processAdd(FieldMutatingUpdateProcessor.java:118)
at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
at org.apache.solr.update.processor.FieldMutatingUpdateProcessor.processAdd(FieldMutatingUpdateProcessor.java:118)
at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
at org.apache.solr.update.processor.FieldNameMutatingUpdateProcessorFactory$1.processAdd(FieldNameMutatingUpdateProcessorFactory.java:75)
at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
at org.apache.solr.update.processor.FieldMutatingUpdateProcessor.processAdd(FieldMutatingUpdateProcessor.java:118)
at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
at org.apache.solr.update.processor.AbstractDefaultValueUpdateProcessorFactory$DefaultValueUpdateProcessor.processAdd(AbstractDefaultValueUpdateProcessorFactory.java:92)
at org.apache.solr.handler.loader.JavabinLoader$1.update(JavabinLoader.java:98)
at org.apache.solr.client.solrj.request.JavaBinUpdateRequestCodec$1.readOuterMostDocIterator(JavaBinUpdateRequestCodec.java:188)
at org.apache.solr.client.solrj.request.JavaBinUpdateRequestCodec$1.readIterator(JavaBinUpdateRequestCodec.java:144)
at org.apache.solr.common.util.JavaBinCodec.readObject(JavaBinCodec.java:311)
at org.apache.solr.common.util.JavaBinCodec.readVal(JavaBinCodec.java:256)
at org.apache.solr.client.solrj.request.JavaBinUpdateRequestCodec$1.readNamedList(JavaBinUpdateRequestCodec.java:130)
at org.apache.solr.common.util.JavaBinCodec.readObject(JavaBinCodec.java:276)
at org.apache.solr.common.util.JavaBinCodec.readVal(JavaBinCodec.java:256)
at org.apache.solr.common.util.JavaBinCodec.unmarshal(JavaBinCodec.java:178)
at org.apache.solr.client.solrj.request.JavaBinUpdateRequestCodec.unmarshal(JavaBinUpdateRequestCodec.java:195)
at org.apache.solr.handler.loader.JavabinLoader.parseAndLoadDocs(JavabinLoader.java:108)
at org.apache.solr.handler.loader.JavabinLoader.load(JavabinLoader.java:55)
at org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:97)
at org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:68)
at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177)
at org.apache.solr.core.SolrCore.execute(SolrCore.java:2484)
at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:710)
at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:516)
at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382)
at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:426)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
at org.eclipse.jetty.server.Server.handle(Server.java:534)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108)
at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.NRTCachingDirectory
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:92)
at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:742)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:935)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:844)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1036)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:948)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:91)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:384)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:389)
at org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174)
at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177)
at org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:735)
at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:716)
at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:497)
at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382)
at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:426)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
at org.eclipse.jetty.server.Server.handle(Server.java:534)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108)
at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
at java.lang.Thread.run(Thread.java:748)
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.NRTCachingDirectory
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348)
at org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:479)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:929)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:844)
at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1036)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:948)
at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:91)
at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:384)
at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:389)
at org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174)
at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177)
at org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:735)
at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:716)
at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:497)
at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382)
at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:426)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
at org.eclipse.jetty.server.Server.handle(Server.java:534)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108)
at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([8D8C5AFB8278C078]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNull(Assert.java:551)
at org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:295)
at sun.reflect.GeneratedMethodAccessor35.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:897)
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 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.lang.Thread.run(Thread.java:748)
FAILED: junit.framework.TestSuite.org.apache.solr.util.TestSolrCLIRunExample
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\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index\write.lock: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index\write.lock C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index\_0_Lucene50_0.tim: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index\_0_Lucene50_0.tim C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index\_0_Lucene70_0.dvd: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index\_0_Lucene70_0.dvd C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index\_0_Lucene50_0.doc: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index\_0_Lucene50_0.doc C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index\_0.fdt: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index\_0.fdt C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\tlog\tlog.0000000000000000000: java.nio.file.FileSystemException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\tlog\tlog.0000000000000000000: The process cannot access the file because it is being used by another process. C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\tlog: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\tlog C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4 C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1 C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007 C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-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\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index\write.lock: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index\write.lock
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index\_0_Lucene50_0.tim: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index\_0_Lucene50_0.tim
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index\_0_Lucene70_0.dvd: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index\_0_Lucene70_0.dvd
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index\_0_Lucene50_0.doc: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index\_0_Lucene50_0.doc
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index\_0.fdt: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index\_0.fdt
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\index
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\tlog\tlog.0000000000000000000: java.nio.file.FileSystemException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\tlog\tlog.0000000000000000000: The process cannot access the file because it is being used by another process.
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\tlog: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data\tlog
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4\data
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-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.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.cloud.autoscaling.ExecutePlanActionTest.testIntegration
Error Message:
Timed out waiting for replicas of collection to be 2 again null Live Nodes: [127.0.0.1:50051_solr] Last available state: DocCollection(testIntegration//collections/testIntegration/state.json/8)={ "pullReplicas":"0", "replicationFactor":"2", "shards":{"shard1":{ "range":"80000000-7fffffff", "state":"active", "replicas":{ "core_node3":{ "core":"testIntegration_shard1_replica_n1", "base_url":"http://127.0.0.1:50051/solr", "node_name":"127.0.0.1:50051_solr", "state":"active", "type":"NRT", "leader":"true"}, "core_node4":{ "core":"testIntegration_shard1_replica_n2", "base_url":"http://127.0.0.1:50054/solr", "node_name":"127.0.0.1:50054_solr", "state":"down", "type":"NRT"}}}}, "router":{"name":"compositeId"}, "maxShardsPerNode":"1", "autoAddReplicas":"false", "nrtReplicas":"2", "tlogReplicas":"0"}
Stack Trace:
java.lang.AssertionError: Timed out waiting for replicas of collection to be 2 again
null
Live Nodes: [127.0.0.1:50051_solr]
Last available state: DocCollection(testIntegration//collections/testIntegration/state.json/8)={
"pullReplicas":"0",
"replicationFactor":"2",
"shards":{"shard1":{
"range":"80000000-7fffffff",
"state":"active",
"replicas":{
"core_node3":{
"core":"testIntegration_shard1_replica_n1",
"base_url":"http://127.0.0.1:50051/solr",
"node_name":"127.0.0.1:50051_solr",
"state":"active",
"type":"NRT",
"leader":"true"},
"core_node4":{
"core":"testIntegration_shard1_replica_n2",
"base_url":"http://127.0.0.1:50054/solr",
"node_name":"127.0.0.1:50054_solr",
"state":"down",
"type":"NRT"}}}},
"router":{"name":"compositeId"},
"maxShardsPerNode":"1",
"autoAddReplicas":"false",
"nrtReplicas":"2",
"tlogReplicas":"0"}
at __randomizedtesting.SeedInfo.seed([8D8C5AFB8278C078:3DED54D7A747615D]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.cloud.SolrCloudTestCase.waitForState(SolrCloudTestCase.java:269)
at org.apache.solr.cloud.autoscaling.ExecutePlanActionTest.testIntegration(ExecutePlanActionTest.java:209)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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 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.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 11671 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_8D8C5AFB8278C078-001\init-core-data-001
[junit4] 2> 90787 WARN (SUITE-TriggerIntegrationTest-seed#[8D8C5AFB8278C078]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 90787 INFO (SUITE-TriggerIntegrationTest-seed#[8D8C5AFB8278C078]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 90793 INFO (SUITE-TriggerIntegrationTest-seed#[8D8C5AFB8278C078]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 90793 INFO (SUITE-TriggerIntegrationTest-seed#[8D8C5AFB8278C078]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 90798 INFO (SUITE-TriggerIntegrationTest-seed#[8D8C5AFB8278C078]-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_8D8C5AFB8278C078-001\tempDir-001
[junit4] 2> 90799 INFO (SUITE-TriggerIntegrationTest-seed#[8D8C5AFB8278C078]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 90800 INFO (Thread-105) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 90800 INFO (Thread-105) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 90806 ERROR (Thread-105) [ ] 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> 90913 INFO (SUITE-TriggerIntegrationTest-seed#[8D8C5AFB8278C078]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:65177
[junit4] 2> 90931 INFO (jetty-launcher-61-thread-1) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 90931 INFO (jetty-launcher-61-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1800e0d{/solr,null,AVAILABLE}
[junit4] 2> 90932 INFO (jetty-launcher-61-thread-2) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 90933 INFO (jetty-launcher-61-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@18b4948{/solr,null,AVAILABLE}
[junit4] 2> 90935 INFO (jetty-launcher-61-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@937d77{HTTP/1.1,[http/1.1]}{127.0.0.1:65182}
[junit4] 2> 90935 INFO (jetty-launcher-61-thread-2) [ ] o.e.j.s.Server Started @104391ms
[junit4] 2> 90935 INFO (jetty-launcher-61-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=65182}
[junit4] 2> 90939 ERROR (jetty-launcher-61-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 90939 INFO (jetty-launcher-61-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.2.0
[junit4] 2> 90939 INFO (jetty-launcher-61-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 90939 INFO (jetty-launcher-61-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null
[junit4] 2> 90939 INFO (jetty-launcher-61-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-10-20T10:35:02.518Z
[junit4] 2> 90941 INFO (jetty-launcher-61-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@147152{HTTP/1.1,[http/1.1]}{127.0.0.1:65181}
[junit4] 2> 90941 INFO (jetty-launcher-61-thread-1) [ ] o.e.j.s.Server Started @104397ms
[junit4] 2> 90941 INFO (jetty-launcher-61-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=65181}
[junit4] 2> 90941 ERROR (jetty-launcher-61-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 90941 INFO (jetty-launcher-61-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.2.0
[junit4] 2> 90941 INFO (jetty-launcher-61-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 90941 INFO (jetty-launcher-61-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null
[junit4] 2> 90941 INFO (jetty-launcher-61-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-10-20T10:35:02.520Z
[junit4] 2> 90958 INFO (jetty-launcher-61-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 90962 INFO (jetty-launcher-61-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 90978 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 0x15f3959b9700002, 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.lang.Thread.run(Thread.java:748)
[junit4] 2> 90979 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 0x15f3959b9700001, 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.lang.Thread.run(Thread.java:748)
[junit4] 2> 90986 INFO (jetty-launcher-61-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:65177/solr
[junit4] 2> 90988 INFO (jetty-launcher-61-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:65177/solr
[junit4] 2> 91000 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 0x15f3959b9700003, 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.lang.Thread.run(Thread.java:748)
[junit4] 2> 91203 INFO (jetty-launcher-61-thread-1) [n:127.0.0.1:65181_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 91203 INFO (jetty-launcher-61-thread-2) [n:127.0.0.1:65182_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 91204 INFO (jetty-launcher-61-thread-1) [n:127.0.0.1:65181_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:65181_solr
[junit4] 2> 91205 INFO (jetty-launcher-61-thread-2) [n:127.0.0.1:65182_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:65182_solr
[junit4] 2> 91207 INFO (jetty-launcher-61-thread-1) [n:127.0.0.1:65181_solr ] o.a.s.c.Overseer Overseer (id=98860774351437830-127.0.0.1:65181_solr-n_0000000000) starting
[junit4] 2> 91208 INFO (zkCallback-72-thread-1-processing-n:127.0.0.1:65182_solr) [n:127.0.0.1:65182_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 91211 INFO (zkCallback-73-thread-1-processing-n:127.0.0.1:65181_solr) [n:127.0.0.1:65181_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 91230 INFO (jetty-launcher-61-thread-1) [n:127.0.0.1:65181_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:65181_solr
[junit4] 2> 91303 INFO (zkCallback-73-thread-1-processing-n:127.0.0.1:65181_solr) [n:127.0.0.1:65181_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 91304 INFO (zkCallback-72-thread-1-processing-n:127.0.0.1:65182_solr) [n:127.0.0.1:65182_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 91316 DEBUG (OverseerAutoScalingTriggerThread-98860774351437830-127.0.0.1:65181_solr-n_0000000000) [n:127.0.0.1:65181_solr ] o.a.s.c.a.OverseerTriggerThread Adding .autoAddReplicas trigger
[junit4] 2> 91317 DEBUG (OverseerAutoScalingTriggerThread-98860774351437830-127.0.0.1:65181_solr-n_0000000000) [n:127.0.0.1:65181_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1
[junit4] 2> 91318 DEBUG (OverseerAutoScalingTriggerThread-98860774351437830-127.0.0.1:65181_solr-n_0000000000) [n:127.0.0.1:65181_solr ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:65181_solr, 127.0.0.1:65182_solr]
[junit4] 2> 91318 DEBUG (OverseerAutoScalingTriggerThread-98860774351437830-127.0.0.1:65181_solr-n_0000000000) [n:127.0.0.1:65181_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion -1
[junit4] 2> 91318 DEBUG (OverseerAutoScalingTriggerThread-98860774351437830-127.0.0.1:65181_solr-n_0000000000) [n:127.0.0.1:65181_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
[junit4] 2> 91321 DEBUG (OverseerAutoScalingTriggerThread-98860774351437830-127.0.0.1:65181_solr-n_0000000000) [n:127.0.0.1:65181_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
[junit4] 2> 91321 DEBUG (OverseerAutoScalingTriggerThread-98860774351437830-127.0.0.1:65181_solr-n_0000000000) [n:127.0.0.1:65181_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
[junit4] 2> 91323 DEBUG (ScheduledTrigger-215-thread-1) [n:127.0.0.1:65181_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: [127.0.0.1:65181_solr, 127.0.0.1:65182_solr]
[junit4] 2> 91510 INFO (jetty-launcher-61-thread-2) [n:127.0.0.1:65182_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_65182.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@106b09f
[junit4] 2> 91520 INFO (jetty-launcher-61-thread-2) [n:127.0.0.1:65182_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_65182.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@106b09f
[junit4] 2> 91521 INFO (jetty-launcher-61-thread-2) [n:127.0.0.1:65182_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_65182.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@106b09f
[junit4] 2> 91527 INFO (jetty-launcher-61-thread-2) [n:127.0.0.1:65182_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_8D8C5AFB8278C078-001\tempDir-001\node2\.
[junit4] 2> 91529 INFO (jetty-launcher-61-thread-1) [n:127.0.0.1:65181_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_65181.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@106b09f
[junit4] 2> 91544 INFO (jetty-launcher-61-thread-1) [n:127.0.0.1:65181_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_65181.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@106b09f
[junit4] 2> 91544 INFO (jetty-launcher-61-thread-1) [n:127.0.0.1:65181_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_65181.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@106b09f
[junit4] 2> 91546 INFO (jetty-launcher-61-thread-1) [n:127.0.0.1:65181_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_8D8C5AFB8278C078-001\tempDir-001\node1\.
[junit4] 2> 91613 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 0x15f3959b9700007, 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.lang.Thread.run(Thread.java:748)
[junit4] 2> 91623 INFO (SUITE-TriggerIntegrationTest-seed#[8D8C5AFB8278C078]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 91624 INFO (SUITE-TriggerIntegrationTest-seed#[8D8C5AFB8278C078]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:65177/solr ready
[junit4] 2> 91643 INFO (TEST-TriggerIntegrationTest.testNodeAddedTrigger-seed#[8D8C5AFB8278C078]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testNodeAddedTrigger
[junit4] 2> 91644 INFO (TEST-TriggerIntegrationTest.testNodeAddedTrigger-seed#[8D8C5AFB8278C078]) [ ] o.a.s.c.a.TriggerIntegrationTest /autoscaling.json reset, new znode version 2
[junit4] 2> 91644 DEBUG (zkCallback-73-thread-1-processing-n:127.0.0.1:65181_solr) [n:127.0.0.1:65181_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 2
[junit4] 2> 91645 DEBUG (OverseerAutoScalingTriggerThread-98860774351437830-127.0.0.1:65181_solr-n_0000000000) [n:127.0.0.1:65181_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
[junit4] 2> 91649 DEBUG (OverseerAutoScalingTriggerThread-98860774351437830-127.0.0.1:65181_solr-n_0000000000) [n:127.0.0.1:65181_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
[junit4] 2> 91650 DEBUG (OverseerAutoScalingTriggerThread-98860774351437830-127.0.0.1:65181_solr-n_0000000000) [n:127.0.0.1:65181_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
[junit4] 2> 91652 DEBUG (OverseerAutoScalingTriggerThread-98860774351437830-127.0.0.1:65181_solr-n_0000000000) [n:127.0.0.1:65181_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
[junit4] 2> 91709 INFO (qtp24745374-458) [n:127.0.0.1:65182_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 91715 INFO (qtp24745374-458) [n:127.0.0.1:65182_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:65177/solr ready
[junit4] 2> 91769 INFO (qtp31161019-443) [n:127.0.0.1:65181_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=10
[junit4] 2> 91774 INFO (qtp24745374-456) [n:127.0.0.1:65182_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> 91775 DEBUG (qtp24745374-458) [n:127.0.0.1:65182_solr ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 91777 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 0x15f3959b9700009, 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.lang.Thread.run(Thread.java:748)
[junit4] 2> 91782 INFO (qtp24745374-458) [n:127.0.0.1:65182_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=100
[junit4] 2> 91789 DEBUG (zkCallback-73-thread-1-processing-n:127.0.0.1:65181_solr) [n:127.0.0.1:65181_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 3
[junit4] 2> 91798 DEBUG (zkCallback-73-thread-1-processing-n:127.0.0.1:65181_solr) [n:127.0.0.1:65181_solr ] o.a.s.c.a.NodeAddedTrigger Initial livenodes: [127.0.0.1:65181_solr, 127.0.0.1:65182_solr]
[junit4] 2> 91798 DEBUG (zkCallback-73-thread-1-processing-n:127.0.0.1:65181_solr) [n:127.0.0.1:65181_solr ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger instantiated with properties: {event=nodeAdded, waitFor=3, actions=[{name=test, class=org.apache.solr.cloud.autoscaling.TriggerIntegrationTest$TestTriggerAction}], enabled=true}
[junit4] 2> 91798 DEBUG (OverseerAutoScalingTriggerThread-98860774351437830-127.0.0.1:65181_solr-n_0000000000) [n:127.0.0.1:65181_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 3
[junit4] 2> 91808 INFO (OverseerAutoScalingTriggerThread-98860774351437830-127.0.0.1:65181_solr-n_0000000000) [n:127.0.0.1:65181_solr ] o.a.s.c.a.TriggerIntegrationTest TestTriggerAction init
[junit4] 2> 91811 INFO (TEST-TriggerIntegrationTest.testNodeAddedTrigger-seed#[8D8C5AFB8278C078]) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 91812 INFO (TEST-TriggerIntegrationTest.testNodeAddedTrigger-seed#[8D8C5AFB8278C078]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@76fad9{/solr,null,AVAILABLE}
[junit4] 2> 91813 INFO (TEST-TriggerIntegrationTest.testNodeAddedTrigger-seed#[8D8C5AFB8278C078]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1ed4334{HTTP/1.1,[http/1.1]}{127.0.0.1:65217}
[junit4] 2> 91813 INFO (TEST-TriggerIntegrationTest.testNodeAddedTrigger-seed#[8D8C5AFB8278C078]) [ ] o.e.j.s.Server Started @105269ms
[junit4] 2> 91813 INFO (TEST-TriggerIntegrationTest.testNodeAddedTrigger-seed#[8D8C5AFB8278C078]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=65217}
[junit4] 2> 91816 ERROR (TEST-TriggerIntegrationTest.testNodeAddedTrigger-seed#[8D8C5AFB8278C078]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 91833 INFO (TEST-TriggerIntegrationTest.testNodeAddedTrigger-seed#[8D8C5AFB8278C078]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.2.0
[junit4] 2> 91833 INFO (TEST-TriggerIntegrationTest.testNodeAddedTrigger-seed#[8D8C5AFB8278C078]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 91833 INFO (TEST-TriggerIntegrationTest.testNodeAddedTrigger-seed#[8D8C5AFB8278C078]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null
[junit4] 2> 91833 INFO (TEST-TriggerIntegrationTest.testNodeAddedTrigger-seed#[8D8C5AFB8278C078]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-10-20T10:35:03.412Z
[junit4] 2> 91835 DEBUG (OverseerAutoScalingTriggerThread-98860774351437830-127.0.0.1:65181_solr-n_0000000000) [n:127.0.0.1:65181_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
[junit4] 2> 91836 DEBUG (OverseerAutoScalingTriggerThread-98860774351437830-127.0.0.1:65181_solr-n_0000000000) [n:127.0.0.1:65181_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion 3
[junit4] 2> 91837 DEBUG (ScheduledTrigger-215-thr
[...truncated too long message...]
t_shard2_replica_n4\data
[junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1\testCloudExamplePrompt_shard2_replica_n4
[junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007\node1
[junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001\tempDir-007
[junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.util.TestSolrCLIRunExample_8D8C5AFB8278C078-001
[junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] Completed [264/744 (3!)] on J0 in 65.95s, 5 tests, 1 failure, 1 error <<< FAILURES!
[...truncated 755 lines...]
[junit4] Suite: org.apache.solr.core.TestJmxIntegration
[junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestJmxIntegration_8D8C5AFB8278C078-001\init-core-data-001
[junit4] 2> 2498118 WARN (SUITE-TestJmxIntegration-seed#[8D8C5AFB8278C078]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=66 numCloses=66
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestJmxIntegration -Dtests.method=testJmxRegistration -Dtests.seed=8D8C5AFB8278C078 -Dtests.slow=true -Dtests.locale=en-ZA -Dtests.timezone=Europe/Saratov -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.15s J0 | TestJmxIntegration.testJmxRegistration <<<
[junit4] > Throwable #1: javax.management.RuntimeMBeanException: org.apache.lucene.store.AlreadyClosedException: this IndexReader is closed
[junit4] > at __randomizedtesting.SeedInfo.seed([8D8C5AFB8278C078:35D3EC1EF39981D]:0)
[junit4] > at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.rethrow(DefaultMBeanServerInterceptor.java:839)
[junit4] > at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.rethrowMaybeMBeanException(DefaultMBeanServerInterceptor.java:852)
[junit4] > at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getAttribute(DefaultMBeanServerInterceptor.java:651)
[junit4] > at com.sun.jmx.mbeanserver.JmxMBeanServer.getAttribute(JmxMBeanServer.java:678)
[junit4] > at org.apache.solr.core.TestJmxIntegration.testJmxRegistration(TestJmxIntegration.java:124)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > Caused by: org.apache.lucene.store.AlreadyClosedException: this IndexReader is closed
[junit4] > at org.apache.lucene.index.IndexReader.ensureOpen(IndexReader.java:268)
[junit4] > at org.apache.lucene.index.StandardDirectoryReader.getVersion(StandardDirectoryReader.java:338)
[junit4] > at org.apache.lucene.index.FilterDirectoryReader.getVersion(FilterDirectoryReader.java:119)
[junit4] > at org.apache.lucene.index.FilterDirectoryReader.getVersion(FilterDirectoryReader.java:119)
[junit4] > at org.apache.solr.search.SolrIndexSearcher.lambda$initializeMetrics$14(SolrIndexSearcher.java:2254)
[junit4] > at org.apache.solr.metrics.reporters.jmx.JmxMetricsReporter$JmxGauge.getValue(JmxMetricsReporter.java:209)
[junit4] > at com.sun.jmx.mbeanserver.StandardMBeanIntrospector.invokeM2(StandardMBeanIntrospector.java:112)
[junit4] > at com.sun.jmx.mbeanserver.StandardMBeanIntrospector.invokeM2(StandardMBeanIntrospector.java:46)
[junit4] > at com.sun.jmx.mbeanserver.MBeanIntrospector.invokeM(MBeanIntrospector.java:237)
[junit4] > at com.sun.jmx.mbeanserver.PerInterface.getAttribute(PerInterface.java:83)
[junit4] > at com.sun.jmx.mbeanserver.MBeanSupport.getAttribute(MBeanSupport.java:206)
[junit4] > at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getAttribute(DefaultMBeanServerInterceptor.java:647)
[junit4] > ... 41 more
[junit4] IGNOR/A 0.00s J0 | TestJmxIntegration.testJmxOnCoreReload
[junit4] > Assumption #1: 'awaitsfix' test group is disabled (@AwaitsFix(bugUrl=https://issues.apache.org/jira/browse/SOLR-2715))
[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.core.TestJmxIntegration_8D8C5AFB8278C078-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70), sim=RandomSimilarity(queryNorm=true): {}, locale=en-ZA, timezone=Europe/Saratov
[junit4] 2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_144 (32-bit)/cpus=3,threads=1,free=66177840,total=361234432
[junit4] 2> NOTE: All tests run in this JVM: [PrimitiveFieldTypeTest, TestOnReconnectListenerSupport, SolrSlf4jReporterTest, TestSolr4Spatial, TestSolr4Spatial2, EnumFieldTest, DistributedExpandComponentTest, QueryParsingTest, TriggerIntegrationTest, SpatialHeatmapFacetsTest, SuggesterFSTTest, SuggesterWFSTTest, TestUtils, TestCollapseQParserPlugin, CoreAdminCreateDiscoverTest, AssignBackwardCompatibilityTest, TemplateUpdateProcessorTest, ExecutePlanActionTest, TestFieldResource, ChangedSchemaMergeTest, HdfsChaosMonkeySafeLeaderTest, TestObjectReleaseTracker, TestXIncludeConfig, V2StandaloneTest, DeleteShardTest, HighlighterTest, PreAnalyzedUpdateProcessorTest, CSVRequestHandlerTest, RAMDirectoryFactoryTest, TestJsonFacetRefinement, TestRuleBasedAuthorizationPlugin, SystemLogListenerTest, SolrRequestParserTest, TestAuthenticationFramework, CheckHdfsIndexTest, TestEmbeddedSolrServerAdminHandler, TestExactSharedStatsCache, UnloadDistributedZkTest, SuggesterTest, UtilsToolTest, JvmMetricsTest, ShardRoutingTest, ClusterStateUpdateTest, AutoAddReplicasIntegrationTest, TestFiltering, TestCoreDiscovery, SolrCloudExampleTest, TestSurroundQueryParser, HdfsBasicDistributedZkTest, TestSortByMinMaxFunction, TestManagedResource, TestSchemaManager, TestCopyFieldCollectionResource, DirectUpdateHandlerOptimizeTest, TestDynamicLoading, CollectionTooManyReplicasTest, BlockJoinFacetSimpleTest, ConfigSetsAPITest, TestInfoStreamLogging, CursorMarkTest, TestLMDirichletSimilarityFactory, BlockDirectoryTest, TestSQLHandler, ReturnFieldsTest, DirectUpdateHandlerTest, TestRangeQuery, AnalyticsMergeStrategyTest, TestFieldTypeResource, AddSchemaFieldsUpdateProcessorFactoryTest, DateFieldTest, NotRequiredUniqueKeyTest, SuggesterTSTTest, CoreSorterTest, BitVectorTest, TestUpdate, OverseerTest, TestSolrCLIRunExample, TestSweetSpotSimilarityFactory, TestCloudInspectUtil, TestMaxScoreQueryParser, DistributedQueryComponentOptimizationTest, AddReplicaTest, TestExceedMaxTermLength, CoreMergeIndexesAdminHandlerTest, BadCopyFieldTest, TestCryptoKeys, TestReqParamsAPI, TestReversedWildcardFilterFactory, ConnectionReuseTest, ResponseLogComponentTest, SortByFunctionTest, FastVectorHighlighterTest, ReplicaListTransformerTest, TestStressLiveNodes, TestUseDocValuesAsStored, DataDrivenBlockJoinTest, HdfsSyncSliceTest, RegexBoostProcessorTest, TestCoreAdminApis, TestPseudoReturnFields, DistributedVersionInfoTest, TestLegacyTerms, TestNumericRangeQuery32, CdcrBootstrapTest, TestNumericTokenStream, TestPerFieldSimilarityWithDefaultOverride, HttpSolrCallGetCoreTest, DistanceFunctionTest, QueryResultKeyTest, AtomicUpdatesTest, CloneFieldUpdateProcessorFactoryTest, TestOverriddenPrefixQueryForCustomFieldType, TestInitQParser, MissingSegmentRecoveryTest, ExitableDirectoryReaderTest, TestRequestForwarding, RequiredFieldsTest, TestFieldCacheReopen, TestCloudNestedDocsSort, TestClusterStateMutator, OverseerRolesTest, OutOfBoxZkACLAndCredentialsProvidersTest, BlockJoinFacetDistribTest, TestNumericTerms32, BasicDistributedZkTest, TestSolrDeletionPolicy2, DeleteInactiveReplicaTest, TestWriterPerf, TestDelegationWithHadoopAuth, LeaderElectionTest, TestIBSimilarityFactory, CollectionReloadTest, SolrIndexMetricsTest, HighlighterConfigTest, BinaryUpdateRequestHandlerTest, RecoveryZkTest, SortSpecParsingTest, TestCollationFieldDocValues, ConvertedLegacyTest, TestFieldCacheWithThreads, SolrJmxReporterCloudTest, CreateCollectionCleanupTest, TestFuzzyAnalyzedSuggestions, DistribJoinFromCollectionTest, TimeZoneUtilsTest, TestClusterProperties, TestShortCircuitedRequests, HdfsDirectoryTest, TestOmitPositions, TlogReplayBufferedWhileIndexingTest, SolrCoreMetricManagerTest, CdcrReplicationHandlerTest, DistributedFacetPivotWhiteBoxTest, SpatialFilterTest, TestRandomDVFaceting, TolerantUpdateProcessorTest, TestScoreJoinQPNoScore, StatsReloadRaceTest, TestLeaderElectionWithEmptyReplica, SolrCmdDistributorTest, BlobRepositoryCloudTest, TestPHPSerializedResponseWriter, PathHierarchyTokenizerFactoryTest, TestBinaryField, IndexSchemaTest, OverseerCollectionConfigSetProcessorTest, SmileWriterTest, TestBlobHandler, CleanupOldIndexTest, SpatialRPTFieldTypeTest, TestComplexPhraseQParserPlugin, TestDistributedSearch, TestJmxIntegration]
[junit4] Completed [497/744 (4!)] on J0 in 0.73s, 3 tests, 1 error, 1 skipped <<< FAILURES!
[...truncated 43884 lines...]