Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Windows/552/
Java: 32bit/jdk1.8.0_102 -client -XX:+UseParallelGC
1 tests failed.
FAILED: org.apache.solr.core.TestDynamicLoading.testDynamicLoading
Error Message:
Could not get expected value 'X val changed' for path 'x' full output: {
"responseHeader":{ "status":0, "QTime":0}, "params":{"wt":"json"},
"context":{ "webapp":"", "path":"/test1", "httpMethod":"GET"},
"class":"org.apache.solr.core.BlobStoreTestRequestHandler", "x":"X val"},
from server: null
Stack Trace:
java.lang.AssertionError: Could not get expected value 'X val changed' for
path 'x' full output: {
"responseHeader":{
"status":0,
"QTime":0},
"params":{"wt":"json"},
"context":{
"webapp":"",
"path":"/test1",
"httpMethod":"GET"},
"class":"org.apache.solr.core.BlobStoreTestRequestHandler",
"x":"X val"}, from server: null
at
__randomizedtesting.SeedInfo.seed([957680B73009894C:4D3BADE0C7D42CEC]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.core.TestSolrConfigHandler.testForResponseElement(TestSolrConfigHandler.java:535)
at
org.apache.solr.core.TestDynamicLoading.testDynamicLoading(TestDynamicLoading.java:249)
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:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
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:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
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:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 12425 lines...]
[junit4] Suite: org.apache.solr.core.TestDynamicLoading
[junit4] 2> Creating dataDir:
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\init-core-data-001
[junit4] 2> 2660958 INFO
(SUITE-TestDynamicLoading-seed#[957680B73009894C]-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> 2660958 INFO
(SUITE-TestDynamicLoading-seed#[957680B73009894C]-worker) [ ]
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 2660963 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2660963 INFO (Thread-3831) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2660963 INFO (Thread-3831) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 2661064 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.ZkTestServer start zk server on port:60067
[junit4] 2> 2661102 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 2661110 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 2661114 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 2661119 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1\conf\stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 2661123 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1\conf\protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 2661126 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1\conf\currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 2661131 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1\conf\enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 2661135 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1\conf\open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 2661139 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 2661144 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1\conf\old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 2661148 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1\conf\synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 2661153 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 0x1581a2293880001, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2661997 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\control-001\cores\collection1
[junit4] 2> 2662000 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 2662002 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1615811{/,null,AVAILABLE}
[junit4] 2> 2662005 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@12d5049{HTTP/1.1,[http/1.1]}{127.0.0.1:60086}
[junit4] 2> 2662005 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.e.j.s.Server Started @2665357ms
[junit4] 2> 2662005 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\tempDir-001/control/data,
hostContext=/, hostPort=60086,
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\control-001\cores}
[junit4] 2> 2662006 ERROR
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2662006 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.3.0
[junit4] 2> 2662006 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2662006 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2662007 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-10-31T09:47:04.471Z
[junit4] 2> 2662016 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 2662016 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\control-001\solr.xml
[junit4] 2> 2662055 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 2662057 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:60067/solr
[junit4] 2> 2662113 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C])
[n:127.0.0.1:60086_ ] o.a.s.c.OverseerElectionContext I am going to be the
leader 127.0.0.1:60086_
[junit4] 2> 2662116 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C])
[n:127.0.0.1:60086_ ] o.a.s.c.Overseer Overseer
(id=96856127794839556-127.0.0.1:60086_-n_0000000000) starting
[junit4] 2> 2662133 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C])
[n:127.0.0.1:60086_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:60086_
[junit4] 2> 2662138 INFO
(OverseerStateUpdate-96856127794839556-127.0.0.1:60086_-n_0000000000)
[n:127.0.0.1:60086_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 2662187 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C])
[n:127.0.0.1:60086_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
underneath
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\control-001\cores
[junit4] 2> 2662187 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C])
[n:127.0.0.1:60086_ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 2662193 INFO
(OverseerStateUpdate-96856127794839556-127.0.0.1:60086_-n_0000000000)
[n:127.0.0.1:60086_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 2663234 WARN
(coreLoadExecutor-8685-thread-1-processing-n:127.0.0.1:60086_)
[n:127.0.0.1:60086_ c:control_collection x:collection1] o.a.s.c.Config
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory>
instead.
[junit4] 2> 2663235 INFO
(coreLoadExecutor-8685-thread-1-processing-n:127.0.0.1:60086_)
[n:127.0.0.1:60086_ c:control_collection x:collection1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.3.0
[junit4] 2> 2663291 INFO
(coreLoadExecutor-8685-thread-1-processing-n:127.0.0.1:60086_)
[n:127.0.0.1:60086_ c:control_collection x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 2663473 WARN
(coreLoadExecutor-8685-thread-1-processing-n:127.0.0.1:60086_)
[n:127.0.0.1:60086_ c:control_collection x:collection1] o.a.s.s.IndexSchema
[collection1] default search field in schema is text. WARNING: Deprecated,
please use 'df' on request instead.
[junit4] 2> 2663480 INFO
(coreLoadExecutor-8685-thread-1-processing-n:127.0.0.1:60086_)
[n:127.0.0.1:60086_ c:control_collection x:collection1] o.a.s.s.IndexSchema
Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2663522 INFO
(coreLoadExecutor-8685-thread-1-processing-n:127.0.0.1:60086_)
[n:127.0.0.1:60086_ c:control_collection x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
control_collection
[junit4] 2> 2663524 INFO
(coreLoadExecutor-8685-thread-1-processing-n:127.0.0.1:60086_)
[n:127.0.0.1:60086_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\control-001\cores\collection1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\control-001\cores\collection1\data\]
[junit4] 2> 2663524 INFO
(coreLoadExecutor-8685-thread-1-processing-n:127.0.0.1:60086_)
[n:127.0.0.1:60086_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5dc802
[junit4] 2> 2663526 INFO
(coreLoadExecutor-8685-thread-1-processing-n:127.0.0.1:60086_)
[n:127.0.0.1:60086_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=46, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=27.884765625,
floorSegmentMB=0.353515625, forceMergeDeletesPctAllowed=11.880464942276273,
segmentsPerTier=46.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.5755229268825173
[junit4] 2> 2663538 WARN
(coreLoadExecutor-8685-thread-1-processing-n:127.0.0.1:60086_)
[n:127.0.0.1:60086_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type =
requestHandler,name = /dump,class = DumpRequestHandler,args =
{defaults={a=A,b=B}}}
[junit4] 2> 2663568 INFO
(coreLoadExecutor-8685-thread-1-processing-n:127.0.0.1:60086_)
[n:127.0.0.1:60086_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 2663568 INFO
(coreLoadExecutor-8685-thread-1-processing-n:127.0.0.1:60086_)
[n:127.0.0.1:60086_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2663571 INFO
(coreLoadExecutor-8685-thread-1-processing-n:127.0.0.1:60086_)
[n:127.0.0.1:60086_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2663571 INFO
(coreLoadExecutor-8685-thread-1-processing-n:127.0.0.1:60086_)
[n:127.0.0.1:60086_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2663572 INFO
(coreLoadExecutor-8685-thread-1-processing-n:127.0.0.1:60086_)
[n:127.0.0.1:60086_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 2663573 INFO
(coreLoadExecutor-8685-thread-1-processing-n:127.0.0.1:60086_)
[n:127.0.0.1:60086_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1dd99f0[collection1] main]
[junit4] 2> 2663576 INFO
(coreLoadExecutor-8685-thread-1-processing-n:127.0.0.1:60086_)
[n:127.0.0.1:60086_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 2663576 INFO
(coreLoadExecutor-8685-thread-1-processing-n:127.0.0.1:60086_)
[n:127.0.0.1:60086_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 2663577 INFO
(coreLoadExecutor-8685-thread-1-processing-n:127.0.0.1:60086_)
[n:127.0.0.1:60086_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2663581 INFO
(searcherExecutor-8686-thread-1-processing-n:127.0.0.1:60086_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60086_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore
[collection1] Registered new searcher Searcher@1dd99f0[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2663581 INFO
(coreLoadExecutor-8685-thread-1-processing-n:127.0.0.1:60086_)
[n:127.0.0.1:60086_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1549698047457361920
[junit4] 2> 2663597 INFO
(coreZkRegister-8678-thread-1-processing-n:127.0.0.1:60086_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60086_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 2663597 INFO
(coreZkRegister-8678-thread-1-processing-n:127.0.0.1:60086_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60086_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 2663597 INFO
(coreZkRegister-8678-thread-1-processing-n:127.0.0.1:60086_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60086_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync replicas to http://127.0.0.1:60086/collection1/
[junit4] 2> 2663597 INFO
(coreZkRegister-8678-thread-1-processing-n:127.0.0.1:60086_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60086_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 2663597 INFO
(coreZkRegister-8678-thread-1-processing-n:127.0.0.1:60086_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60086_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
http://127.0.0.1:60086/collection1/ has no replicas
[junit4] 2> 2663607 INFO
(coreZkRegister-8678-thread-1-processing-n:127.0.0.1:60086_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60086_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:60086/collection1/ shard1
[junit4] 2> 2663700 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2663703 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
loss:false
[junit4] 2> 2663759 INFO
(coreZkRegister-8678-thread-1-processing-n:127.0.0.1:60086_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60086_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 2664425 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-1-001\cores\collection1
[junit4] 2> 2664431 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-1-001
[junit4] 2> 2664431 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 2664432 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1118155{/,null,AVAILABLE}
[junit4] 2> 2664435 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@15ebf6{HTTP/1.1,[http/1.1]}{127.0.0.1:60119}
[junit4] 2> 2664435 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.e.j.s.Server Started @2667787ms
[junit4] 2> 2664435 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\tempDir-001/jetty1,
solrconfig=solrconfig.xml, hostContext=/, hostPort=60119,
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-1-001\cores}
[junit4] 2> 2664435 ERROR
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2664436 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.3.0
[junit4] 2> 2664436 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2664436 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2664436 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-10-31T09:47:06.900Z
[junit4] 2> 2664443 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 2664443 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-1-001\solr.xml
[junit4] 2> 2664462 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 2664463 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:60067/solr
[junit4] 2> 2664483 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C])
[n:127.0.0.1:60119_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 2664493 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C])
[n:127.0.0.1:60119_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:60119_
[junit4] 2> 2664496 INFO
(zkCallback-10305-thread-1-processing-n:127.0.0.1:60086_) [n:127.0.0.1:60086_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2664498 INFO
(zkCallback-10314-thread-1-processing-n:127.0.0.1:60119_) [n:127.0.0.1:60119_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2664498 INFO (zkCallback-10309-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2664543 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C])
[n:127.0.0.1:60119_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
underneath
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-1-001\cores
[junit4] 2> 2664543 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C])
[n:127.0.0.1:60119_ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 2664548 INFO
(OverseerStateUpdate-96856127794839556-127.0.0.1:60086_-n_0000000000)
[n:127.0.0.1:60086_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard2
[junit4] 2> 2665591 WARN
(coreLoadExecutor-8696-thread-1-processing-n:127.0.0.1:60119_)
[n:127.0.0.1:60119_ c:collection1 x:collection1] o.a.s.c.Config Beginning
with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 2665593 INFO
(coreLoadExecutor-8696-thread-1-processing-n:127.0.0.1:60119_)
[n:127.0.0.1:60119_ c:collection1 x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 6.3.0
[junit4] 2> 2665624 INFO
(coreLoadExecutor-8696-thread-1-processing-n:127.0.0.1:60119_)
[n:127.0.0.1:60119_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 2665800 WARN
(coreLoadExecutor-8696-thread-1-processing-n:127.0.0.1:60119_)
[n:127.0.0.1:60119_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] default search field in schema is text. WARNING: Deprecated,
please use 'df' on request instead.
[junit4] 2> 2665803 INFO
(coreLoadExecutor-8696-thread-1-processing-n:127.0.0.1:60119_)
[n:127.0.0.1:60119_ c:collection1 x:collection1] o.a.s.s.IndexSchema Loaded
schema test/1.0 with uniqueid field id
[junit4] 2> 2665841 INFO
(coreLoadExecutor-8696-thread-1-processing-n:127.0.0.1:60119_)
[n:127.0.0.1:60119_ c:collection1 x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection collection1
[junit4] 2> 2665842 INFO
(coreLoadExecutor-8696-thread-1-processing-n:127.0.0.1:60119_)
[n:127.0.0.1:60119_ c:collection1 s:shard2 r:core_node1 x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-1-001\cores\collection1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-1-001\cores\collection1\data\]
[junit4] 2> 2665842 INFO
(coreLoadExecutor-8696-thread-1-processing-n:127.0.0.1:60119_)
[n:127.0.0.1:60119_ c:collection1 s:shard2 r:core_node1 x:collection1]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5dc802
[junit4] 2> 2665844 INFO
(coreLoadExecutor-8696-thread-1-processing-n:127.0.0.1:60119_)
[n:127.0.0.1:60119_ c:collection1 s:shard2 r:core_node1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=46, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=27.884765625,
floorSegmentMB=0.353515625, forceMergeDeletesPctAllowed=11.880464942276273,
segmentsPerTier=46.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.5755229268825173
[junit4] 2> 2665854 WARN
(coreLoadExecutor-8696-thread-1-processing-n:127.0.0.1:60119_)
[n:127.0.0.1:60119_ c:collection1 s:shard2 r:core_node1 x:collection1]
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type =
requestHandler,name = /dump,class = DumpRequestHandler,args =
{defaults={a=A,b=B}}}
[junit4] 2> 2665885 INFO
(coreLoadExecutor-8696-thread-1-processing-n:127.0.0.1:60119_)
[n:127.0.0.1:60119_ c:collection1 s:shard2 r:core_node1 x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 2665885 INFO
(coreLoadExecutor-8696-thread-1-processing-n:127.0.0.1:60119_)
[n:127.0.0.1:60119_ c:collection1 s:shard2 r:core_node1 x:collection1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2665887 INFO
(coreLoadExecutor-8696-thread-1-processing-n:127.0.0.1:60119_)
[n:127.0.0.1:60119_ c:collection1 s:shard2 r:core_node1 x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2665887 INFO
(coreLoadExecutor-8696-thread-1-processing-n:127.0.0.1:60119_)
[n:127.0.0.1:60119_ c:collection1 s:shard2 r:core_node1 x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2665889 INFO
(coreLoadExecutor-8696-thread-1-processing-n:127.0.0.1:60119_)
[n:127.0.0.1:60119_ c:collection1 s:shard2 r:core_node1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 2665889 INFO
(coreLoadExecutor-8696-thread-1-processing-n:127.0.0.1:60119_)
[n:127.0.0.1:60119_ c:collection1 s:shard2 r:core_node1 x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@128a1b6[collection1] main]
[junit4] 2> 2665892 INFO
(coreLoadExecutor-8696-thread-1-processing-n:127.0.0.1:60119_)
[n:127.0.0.1:60119_ c:collection1 s:shard2 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 2665893 INFO
(coreLoadExecutor-8696-thread-1-processing-n:127.0.0.1:60119_)
[n:127.0.0.1:60119_ c:collection1 s:shard2 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 2665894 INFO
(coreLoadExecutor-8696-thread-1-processing-n:127.0.0.1:60119_)
[n:127.0.0.1:60119_ c:collection1 s:shard2 r:core_node1 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2665899 INFO
(searcherExecutor-8697-thread-1-processing-n:127.0.0.1:60119_ x:collection1
s:shard2 c:collection1 r:core_node1) [n:127.0.0.1:60119_ c:collection1 s:shard2
r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new
searcher Searcher@128a1b6[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2665900 INFO
(coreLoadExecutor-8696-thread-1-processing-n:127.0.0.1:60119_)
[n:127.0.0.1:60119_ c:collection1 s:shard2 r:core_node1 x:collection1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1549698049889009664
[junit4] 2> 2665916 INFO
(coreZkRegister-8691-thread-1-processing-n:127.0.0.1:60119_ x:collection1
s:shard2 c:collection1 r:core_node1) [n:127.0.0.1:60119_ c:collection1 s:shard2
r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas
found to continue.
[junit4] 2> 2665917 INFO
(coreZkRegister-8691-thread-1-processing-n:127.0.0.1:60119_ x:collection1
s:shard2 c:collection1 r:core_node1) [n:127.0.0.1:60119_ c:collection1 s:shard2
r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new
leader - try and sync
[junit4] 2> 2665917 INFO
(coreZkRegister-8691-thread-1-processing-n:127.0.0.1:60119_ x:collection1
s:shard2 c:collection1 r:core_node1) [n:127.0.0.1:60119_ c:collection1 s:shard2
r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:60119/collection1/
[junit4] 2> 2665917 INFO
(coreZkRegister-8691-thread-1-processing-n:127.0.0.1:60119_ x:collection1
s:shard2 c:collection1 r:core_node1) [n:127.0.0.1:60119_ c:collection1 s:shard2
r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync
replicas to me
[junit4] 2> 2665917 INFO
(coreZkRegister-8691-thread-1-processing-n:127.0.0.1:60119_ x:collection1
s:shard2 c:collection1 r:core_node1) [n:127.0.0.1:60119_ c:collection1 s:shard2
r:core_node1 x:collection1] o.a.s.c.SyncStrategy
http://127.0.0.1:60119/collection1/ has no replicas
[junit4] 2> 2665925 INFO
(coreZkRegister-8691-thread-1-processing-n:127.0.0.1:60119_ x:collection1
s:shard2 c:collection1 r:core_node1) [n:127.0.0.1:60119_ c:collection1 s:shard2
r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new
leader: http://127.0.0.1:60119/collection1/ shard2
[junit4] 2> 2666079 INFO
(coreZkRegister-8691-thread-1-processing-n:127.0.0.1:60119_ x:collection1
s:shard2 c:collection1 r:core_node1) [n:127.0.0.1:60119_ c:collection1 s:shard2
r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery
necessary
[junit4] 2> 2666804 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-2-001\cores\collection1
[junit4] 2> 2666807 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-2-001
[junit4] 2> 2666808 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 2666809 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@ffe518{/,null,AVAILABLE}
[junit4] 2> 2666810 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@1be5458{HTTP/1.1,[http/1.1]}{127.0.0.1:60143}
[junit4] 2> 2666810 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.e.j.s.Server Started @2670162ms
[junit4] 2> 2666810 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\tempDir-001/jetty2,
solrconfig=solrconfig.xml, hostContext=/, hostPort=60143,
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-2-001\cores}
[junit4] 2> 2666812 ERROR
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2666812 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.3.0
[junit4] 2> 2666812 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2666812 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2666812 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-10-31T09:47:09.276Z
[junit4] 2> 2666818 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 2666818 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-2-001\solr.xml
[junit4] 2> 2666839 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 2666840 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:60067/solr
[junit4] 2> 2666863 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C])
[n:127.0.0.1:60143_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 2666873 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C])
[n:127.0.0.1:60143_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:60143_
[junit4] 2> 2666876 INFO
(zkCallback-10305-thread-1-processing-n:127.0.0.1:60086_) [n:127.0.0.1:60086_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2666876 INFO (zkCallback-10309-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2666876 INFO
(zkCallback-10314-thread-1-processing-n:127.0.0.1:60119_) [n:127.0.0.1:60119_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2666877 INFO
(zkCallback-10320-thread-1-processing-n:127.0.0.1:60143_) [n:127.0.0.1:60143_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2666905 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C])
[n:127.0.0.1:60143_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
underneath
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-2-001\cores
[junit4] 2> 2666906 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C])
[n:127.0.0.1:60143_ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 2666909 INFO
(OverseerStateUpdate-96856127794839556-127.0.0.1:60086_-n_0000000000)
[n:127.0.0.1:60086_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 2667939 WARN
(coreLoadExecutor-8707-thread-1-processing-n:127.0.0.1:60143_)
[n:127.0.0.1:60143_ c:collection1 x:collection1] o.a.s.c.Config Beginning
with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 2667940 INFO
(coreLoadExecutor-8707-thread-1-processing-n:127.0.0.1:60143_)
[n:127.0.0.1:60143_ c:collection1 x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 6.3.0
[junit4] 2> 2667982 INFO
(coreLoadExecutor-8707-thread-1-processing-n:127.0.0.1:60143_)
[n:127.0.0.1:60143_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 2668136 WARN
(coreLoadExecutor-8707-thread-1-processing-n:127.0.0.1:60143_)
[n:127.0.0.1:60143_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] default search field in schema is text. WARNING: Deprecated,
please use 'df' on request instead.
[junit4] 2> 2668140 INFO
(coreLoadExecutor-8707-thread-1-processing-n:127.0.0.1:60143_)
[n:127.0.0.1:60143_ c:collection1 x:collection1] o.a.s.s.IndexSchema Loaded
schema test/1.0 with uniqueid field id
[junit4] 2> 2668178 INFO
(coreLoadExecutor-8707-thread-1-processing-n:127.0.0.1:60143_)
[n:127.0.0.1:60143_ c:collection1 x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection collection1
[junit4] 2> 2668179 INFO
(coreLoadExecutor-8707-thread-1-processing-n:127.0.0.1:60143_)
[n:127.0.0.1:60143_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-2-001\cores\collection1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-2-001\cores\collection1\data\]
[junit4] 2> 2668179 INFO
(coreLoadExecutor-8707-thread-1-processing-n:127.0.0.1:60143_)
[n:127.0.0.1:60143_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5dc802
[junit4] 2> 2668180 INFO
(coreLoadExecutor-8707-thread-1-processing-n:127.0.0.1:60143_)
[n:127.0.0.1:60143_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=46, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=27.884765625,
floorSegmentMB=0.353515625, forceMergeDeletesPctAllowed=11.880464942276273,
segmentsPerTier=46.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.5755229268825173
[junit4] 2> 2668187 WARN
(coreLoadExecutor-8707-thread-1-processing-n:127.0.0.1:60143_)
[n:127.0.0.1:60143_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type =
requestHandler,name = /dump,class = DumpRequestHandler,args =
{defaults={a=A,b=B}}}
[junit4] 2> 2668223 INFO
(coreLoadExecutor-8707-thread-1-processing-n:127.0.0.1:60143_)
[n:127.0.0.1:60143_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 2668223 INFO
(coreLoadExecutor-8707-thread-1-processing-n:127.0.0.1:60143_)
[n:127.0.0.1:60143_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2668225 INFO
(coreLoadExecutor-8707-thread-1-processing-n:127.0.0.1:60143_)
[n:127.0.0.1:60143_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2668225 INFO
(coreLoadExecutor-8707-thread-1-processing-n:127.0.0.1:60143_)
[n:127.0.0.1:60143_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2668226 INFO
(coreLoadExecutor-8707-thread-1-processing-n:127.0.0.1:60143_)
[n:127.0.0.1:60143_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 2668227 INFO
(coreLoadExecutor-8707-thread-1-processing-n:127.0.0.1:60143_)
[n:127.0.0.1:60143_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@122416d[collection1] main]
[junit4] 2> 2668228 INFO
(coreLoadExecutor-8707-thread-1-processing-n:127.0.0.1:60143_)
[n:127.0.0.1:60143_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 2668229 INFO
(coreLoadExecutor-8707-thread-1-processing-n:127.0.0.1:60143_)
[n:127.0.0.1:60143_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 2668230 INFO
(coreLoadExecutor-8707-thread-1-processing-n:127.0.0.1:60143_)
[n:127.0.0.1:60143_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2668232 INFO
(searcherExecutor-8708-thread-1-processing-n:127.0.0.1:60143_ x:collection1
s:shard1 c:collection1 r:core_node2) [n:127.0.0.1:60143_ c:collection1 s:shard1
r:core_node2 x:collection1] o.a.s.c.SolrCore [collection1] Registered new
searcher Searcher@122416d[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2668233 INFO
(coreLoadExecutor-8707-thread-1-processing-n:127.0.0.1:60143_)
[n:127.0.0.1:60143_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1549698052335337472
[junit4] 2> 2668244 INFO
(coreZkRegister-8702-thread-1-processing-n:127.0.0.1:60143_ x:collection1
s:shard1 c:collection1 r:core_node2) [n:127.0.0.1:60143_ c:collection1 s:shard1
r:core_node2 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas
found to continue.
[junit4] 2> 2668244 INFO
(coreZkRegister-8702-thread-1-processing-n:127.0.0.1:60143_ x:collection1
s:shard1 c:collection1 r:core_node2) [n:127.0.0.1:60143_ c:collection1 s:shard1
r:core_node2 x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new
leader - try and sync
[junit4] 2> 2668244 INFO
(coreZkRegister-8702-thread-1-processing-n:127.0.0.1:60143_ x:collection1
s:shard1 c:collection1 r:core_node2) [n:127.0.0.1:60143_ c:collection1 s:shard1
r:core_node2 x:collection1] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:60143/collection1/
[junit4] 2> 2668244 INFO
(coreZkRegister-8702-thread-1-processing-n:127.0.0.1:60143_ x:collection1
s:shard1 c:collection1 r:core_node2) [n:127.0.0.1:60143_ c:collection1 s:shard1
r:core_node2 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync
replicas to me
[junit4] 2> 2668244 INFO
(coreZkRegister-8702-thread-1-processing-n:127.0.0.1:60143_ x:collection1
s:shard1 c:collection1 r:core_node2) [n:127.0.0.1:60143_ c:collection1 s:shard1
r:core_node2 x:collection1] o.a.s.c.SyncStrategy
http://127.0.0.1:60143/collection1/ has no replicas
[junit4] 2> 2668253 INFO
(coreZkRegister-8702-thread-1-processing-n:127.0.0.1:60143_ x:collection1
s:shard1 c:collection1 r:core_node2) [n:127.0.0.1:60143_ c:collection1 s:shard1
r:core_node2 x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new
leader: http://127.0.0.1:60143/collection1/ shard1
[junit4] 2> 2668406 INFO
(coreZkRegister-8702-thread-1-processing-n:127.0.0.1:60143_ x:collection1
s:shard1 c:collection1 r:core_node2) [n:127.0.0.1:60143_ c:collection1 s:shard1
r:core_node2 x:collection1] o.a.s.c.ZkController I am the leader, no recovery
necessary
[junit4] 2> 2669025 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-3-001\cores\collection1
[junit4] 2> 2669028 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-3-001
[junit4] 2> 2669029 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 2669031 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@15d8664{/,null,AVAILABLE}
[junit4] 2> 2669035 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@f4a423{HTTP/1.1,[http/1.1]}{127.0.0.1:60167}
[junit4] 2> 2669035 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.e.j.s.Server Started @2672387ms
[junit4] 2> 2669035 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\tempDir-001/jetty3,
solrconfig=solrconfig.xml, hostContext=/, hostPort=60167,
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-3-001\cores}
[junit4] 2> 2669036 ERROR
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2669036 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.3.0
[junit4] 2> 2669036 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2669036 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2669036 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-10-31T09:47:11.500Z
[junit4] 2> 2669042 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 2669042 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-3-001\solr.xml
[junit4] 2> 2669058 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 2669060 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:60067/solr
[junit4] 2> 2669082 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C])
[n:127.0.0.1:60167_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 2669093 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C])
[n:127.0.0.1:60167_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:60167_
[junit4] 2> 2669097 INFO
(zkCallback-10305-thread-2-processing-n:127.0.0.1:60086_) [n:127.0.0.1:60086_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2669097 INFO (zkCallback-10309-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2669098 INFO
(zkCallback-10326-thread-1-processing-n:127.0.0.1:60167_) [n:127.0.0.1:60167_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2669100 INFO
(zkCallback-10320-thread-1-processing-n:127.0.0.1:60143_) [n:127.0.0.1:60143_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2669100 INFO
(zkCallback-10314-thread-1-processing-n:127.0.0.1:60119_) [n:127.0.0.1:60119_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2669128 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C])
[n:127.0.0.1:60167_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
underneath
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-3-001\cores
[junit4] 2> 2669128 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C])
[n:127.0.0.1:60167_ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 2669131 INFO
(OverseerStateUpdate-96856127794839556-127.0.0.1:60086_-n_0000000000)
[n:127.0.0.1:60086_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard2
[junit4] 2> 2670151 WARN
(coreLoadExecutor-8718-thread-1-processing-n:127.0.0.1:60167_)
[n:127.0.0.1:60167_ c:collection1 x:collection1] o.a.s.c.Config Beginning
with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 2670152 INFO
(coreLoadExecutor-8718-thread-1-processing-n:127.0.0.1:60167_)
[n:127.0.0.1:60167_ c:collection1 x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 6.3.0
[junit4] 2> 2670174 INFO
(coreLoadExecutor-8718-thread-1-processing-n:127.0.0.1:60167_)
[n:127.0.0.1:60167_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 2670315 WARN
(coreLoadExecutor-8718-thread-1-processing-n:127.0.0.1:60167_)
[n:127.0.0.1:60167_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] default search field in schema is text. WARNING: Deprecated,
please use 'df' on request instead.
[junit4] 2> 2670318 INFO
(coreLoadExecutor-8718-thread-1-processing-n:127.0.0.1:60167_)
[n:127.0.0.1:60167_ c:collection1 x:collection1] o.a.s.s.IndexSchema Loaded
schema test/1.0 with uniqueid field id
[junit4] 2> 2670345 INFO
(coreLoadExecutor-8718-thread-1-processing-n:127.0.0.1:60167_)
[n:127.0.0.1:60167_ c:collection1 x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection collection1
[junit4] 2> 2670345 INFO
(coreLoadExecutor-8718-thread-1-processing-n:127.0.0.1:60167_)
[n:127.0.0.1:60167_ c:collection1 s:shard2 r:core_node3 x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-3-001\cores\collection1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-3-001\cores\collection1\data\]
[junit4] 2> 2670345 INFO
(coreLoadExecutor-8718-thread-1-processing-n:127.0.0.1:60167_)
[n:127.0.0.1:60167_ c:collection1 s:shard2 r:core_node3 x:collection1]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5dc802
[junit4] 2> 2670347 INFO
(coreLoadExecutor-8718-thread-1-processing-n:127.0.0.1:60167_)
[n:127.0.0.1:60167_ c:collection1 s:shard2 r:core_node3 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=46, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=27.884765625,
floorSegmentMB=0.353515625, forceMergeDeletesPctAllowed=11.880464942276273,
segmentsPerTier=46.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.5755229268825173
[junit4] 2> 2670354 WARN
(coreLoadExecutor-8718-thread-1-processing-n:127.0.0.1:60167_)
[n:127.0.0.1:60167_ c:collection1 s:shard2 r:core_node3 x:collection1]
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type =
requestHandler,name = /dump,class = DumpRequestHandler,args =
{defaults={a=A,b=B}}}
[junit4] 2> 2670380 INFO
(coreLoadExecutor-8718-thread-1-processing-n:127.0.0.1:60167_)
[n:127.0.0.1:60167_ c:collection1 s:shard2 r:core_node3 x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 2670380 INFO
(coreLoadExecutor-8718-thread-1-processing-n:127.0.0.1:60167_)
[n:127.0.0.1:60167_ c:collection1 s:shard2 r:core_node3 x:collection1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2670381 INFO
(coreLoadExecutor-8718-thread-1-processing-n:127.0.0.1:60167_)
[n:127.0.0.1:60167_ c:collection1 s:shard2 r:core_node3 x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2670381 INFO
(coreLoadExecutor-8718-thread-1-processing-n:127.0.0.1:60167_)
[n:127.0.0.1:60167_ c:collection1 s:shard2 r:core_node3 x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2670382 INFO
(coreLoadExecutor-8718-thread-1-processing-n:127.0.0.1:60167_)
[n:127.0.0.1:60167_ c:collection1 s:shard2 r:core_node3 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 2670382 INFO
(coreLoadExecutor-8718-thread-1-processing-n:127.0.0.1:60167_)
[n:127.0.0.1:60167_ c:collection1 s:shard2 r:core_node3 x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1e2bf87[collection1] main]
[junit4] 2> 2670384 INFO
(coreLoadExecutor-8718-thread-1-processing-n:127.0.0.1:60167_)
[n:127.0.0.1:60167_ c:collection1 s:shard2 r:core_node3 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 2670385 INFO
(coreLoadExecutor-8718-thread-1-processing-n:127.0.0.1:60167_)
[n:127.0.0.1:60167_ c:collection1 s:shard2 r:core_node3 x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 2670385 INFO
(coreLoadExecutor-8718-thread-1-processing-n:127.0.0.1:60167_)
[n:127.0.0.1:60167_ c:collection1 s:shard2 r:core_node3 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2670387 INFO
(searcherExecutor-8719-thread-1-processing-n:127.0.0.1:60167_ x:collection1
s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:60167_ c:collection1 s:shard2
r:core_node3 x:collection1] o.a.s.c.SolrCore [collection1] Registered new
searcher Searcher@1e2bf87[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2670387 INFO
(coreLoadExecutor-8718-thread-1-processing-n:127.0.0.1:60167_)
[n:127.0.0.1:60167_ c:collection1 s:shard2 r:core_node3 x:collection1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1549698054593970176
[junit4] 2> 2670394 INFO
(coreZkRegister-8713-thread-1-processing-n:127.0.0.1:60167_ x:collection1
s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:60167_ c:collection1 s:shard2
r:core_node3 x:collection1] o.a.s.c.ZkController Core needs to
recover:collection1
[junit4] 2> 2670395 INFO
(updateExecutor-10323-thread-1-processing-n:127.0.0.1:60167_ x:collection1
s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:60167_ c:collection1 s:shard2
r:core_node3 x:collection1] o.a.s.u.DefaultSolrCoreState Running recovery
[junit4] 2> 2670395 INFO
(recoveryExecutor-10324-thread-1-processing-n:127.0.0.1:60167_ x:collection1
s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:60167_ c:collection1 s:shard2
r:core_node3 x:collection1] o.a.s.c.RecoveryStrategy Starting recovery process.
recoveringAfterStartup=true
[junit4] 2> 2670396 INFO
(recoveryExecutor-10324-thread-1-processing-n:127.0.0.1:60167_ x:collection1
s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:60167_ c:collection1 s:shard2
r:core_node3 x:collection1] o.a.s.c.RecoveryStrategy ###### startupVersions=[[]]
[junit4] 2> 2670396 INFO
(recoveryExecutor-10324-thread-1-processing-n:127.0.0.1:60167_ x:collection1
s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:60167_ c:collection1 s:shard2
r:core_node3 x:collection1] o.a.s.c.RecoveryStrategy Begin buffering updates.
core=[collection1]
[junit4] 2> 2670396 INFO
(recoveryExecutor-10324-thread-1-processing-n:127.0.0.1:60167_ x:collection1
s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:60167_ c:collection1 s:shard2
r:core_node3 x:collection1] o.a.s.u.UpdateLog Starting to buffer updates.
FSUpdateLog{state=ACTIVE, tlog=null}
[junit4] 2> 2670396 INFO
(recoveryExecutor-10324-thread-1-processing-n:127.0.0.1:60167_ x:collection1
s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:60167_ c:collection1 s:shard2
r:core_node3 x:collection1] o.a.s.c.RecoveryStrategy Publishing state of core
[collection1] as recovering, leader is [http://127.0.0.1:60119/collection1/]
and I am [http://127.0.0.1:60167/collection1/]
[junit4] 2> 2670400 INFO
(recoveryExecutor-10324-thread-1-processing-n:127.0.0.1:60167_ x:collection1
s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:60167_ c:collection1 s:shard2
r:core_node3 x:collection1] o.a.s.c.RecoveryStrategy Sending prep recovery
command to [http://127.0.0.1:60119]; [WaitForState:
action=PREPRECOVERY&core=collection1&nodeName=127.0.0.1:60167_&coreNodeName=core_node3&state=recovering&checkLive=true&onlyIfLeader=true&onlyIfLeaderActive=true]
[junit4] 2> 2670405 INFO (qtp1383266-43874) [n:127.0.0.1:60119_ ]
o.a.s.h.a.PrepRecoveryOp Going to wait for coreNodeName: core_node3, state:
recovering, checkLive: true, onlyIfLeader: true, onlyIfLeaderActive: true
[junit4] 2> 2670406 INFO (qtp1383266-43874) [n:127.0.0.1:60119_ ]
o.a.s.h.a.PrepRecoveryOp Will wait a max of 183 seconds to see collection1
(shard2 of collection1) have state: recovering
[junit4] 2> 2670406 INFO (qtp1383266-43874) [n:127.0.0.1:60119_ ]
o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): collection=collection1,
shard=shard2, thisCore=collection1, leaderDoesNotNeedRecovery=false, isLeader?
true, live=true, checkLive=true, currentState=down, localState=active,
nodeName=127.0.0.1:60167_, coreNodeName=core_node3,
onlyIfActiveCheckResult=false, nodeProps:
core_node3:{"core":"collection1","base_url":"http://127.0.0.1:60167","node_name":"127.0.0.1:60167_","state":"down"}
[junit4] 2> 2671208 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-4-001\cores\collection1
[junit4] 2> 2671211 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 4 in directory
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-4-001
[junit4] 2> 2671212 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 2671213 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@d2554{/,null,AVAILABLE}
[junit4] 2> 2671215 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@17a9a6f{HTTP/1.1,[http/1.1]}{127.0.0.1:60193}
[junit4] 2> 2671215 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.e.j.s.Server Started @2674568ms
[junit4] 2> 2671216 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\tempDir-001/jetty4,
solrconfig=solrconfig.xml, hostContext=/, hostPort=60193,
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-4-001\cores}
[junit4] 2> 2671216 ERROR
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2671217 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.3.0
[junit4] 2> 2671217 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2671217 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2671217 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-10-31T09:47:13.681Z
[junit4] 2> 2671224 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 2671224 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-4-001\solr.xml
[junit4] 2> 2671245 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 2671246 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:60067/solr
[junit4] 2> 2671265 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C])
[n:127.0.0.1:60193_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 2671275 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C])
[n:127.0.0.1:60193_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:60193_
[junit4] 2> 2671280 INFO
(zkCallback-10333-thread-1-processing-n:127.0.0.1:60193_) [n:127.0.0.1:60193_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2671280 INFO
(zkCallback-10320-thread-1-processing-n:127.0.0.1:60143_) [n:127.0.0.1:60143_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2671280 INFO
(zkCallback-10314-thread-1-processing-n:127.0.0.1:60119_) [n:127.0.0.1:60119_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2671280 INFO
(zkCallback-10305-thread-1-processing-n:127.0.0.1:60086_) [n:127.0.0.1:60086_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2671282 INFO (zkCallback-10309-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2671282 INFO
(zkCallback-10326-thread-1-processing-n:127.0.0.1:60167_) [n:127.0.0.1:60167_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2671318 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C])
[n:127.0.0.1:60193_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
underneath
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-4-001\cores
[junit4] 2> 2671318 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C])
[n:127.0.0.1:60193_ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 2671320 INFO
(OverseerStateUpdate-96856127794839556-127.0.0.1:60086_-n_0000000000)
[n:127.0.0.1:60086_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 2671407 INFO (qtp1383266-43874) [n:127.0.0.1:60119_ ]
o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): collection=collection1,
shard=shard2, thisCore=collection1, leaderDoesNotNeedRecovery=false, isLeader?
true, live=true, checkLive=true, currentState=recovering, localState=active,
nodeName=127.0.0.1:60167_, coreNodeName=core_node3,
onlyIfActiveCheckResult=false, nodeProps:
core_node3:{"core":"collection1","base_url":"http://127.0.0.1:60167","node_name":"127.0.0.1:60167_","state":"recovering"}
[junit4] 2> 2671407 INFO (qtp1383266-43874) [n:127.0.0.1:60119_ ]
o.a.s.h.a.PrepRecoveryOp Waited coreNodeName: core_node3, state: recovering,
checkLive: true, onlyIfLeader: true for: 1 seconds.
[junit4] 2> 2671407 INFO (qtp1383266-43874) [n:127.0.0.1:60119_ ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={nodeName=127.0.0.1:60167_&onlyIfLeaderActive=true&core=collection1&coreNodeName=core_node3&action=PREPRECOVERY&checkLive=true&state=recovering&onlyIfLeader=true&wt=javabin&version=2}
status=0 QTime=1000
[junit4] 2> 2672342 WARN
(coreLoadExecutor-8729-thread-1-processing-n:127.0.0.1:60193_)
[n:127.0.0.1:60193_ c:collection1 x:collection1] o.a.s.c.Config Beginning
with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 2672342 INFO
(coreLoadExecutor-8729-thread-1-processing-n:127.0.0.1:60193_)
[n:127.0.0.1:60193_ c:collection1 x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 6.3.0
[junit4] 2> 2672363 INFO
(coreLoadExecutor-8729-thread-1-processing-n:127.0.0.1:60193_)
[n:127.0.0.1:60193_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 2672519 WARN
(coreLoadExecutor-8729-thread-1-processing-n:127.0.0.1:60193_)
[n:127.0.0.1:60193_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] default search field in schema is text. WARNING: Deprecated,
please use 'df' on request instead.
[junit4] 2> 2672524 INFO
(coreLoadExecutor-8729-thread-1-processing-n:127.0.0.1:60193_)
[n:127.0.0.1:60193_ c:collection1 x:collection1] o.a.s.s.IndexSchema Loaded
schema test/1.0 with uniqueid field id
[junit4] 2> 2672557 INFO
(coreLoadExecutor-8729-thread-1-processing-n:127.0.0.1:60193_)
[n:127.0.0.1:60193_ c:collection1 x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection collection1
[junit4] 2> 2672557 INFO
(coreLoadExecutor-8729-thread-1-processing-n:127.0.0.1:60193_)
[n:127.0.0.1:60193_ c:collection1 s:shard1 r:core_node4 x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-4-001\cores\collection1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001\shard-4-001\cores\collection1\data\]
[junit4] 2> 2672558 INFO
(coreLoadExecutor-8729-thread-1-processing-n:127.0.0.1:60193_)
[n:127.0.0.1:60193_ c:collection1 s:shard1 r:core_node4 x:collection1]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5dc802
[junit4] 2> 2672559 INFO
(coreLoadExecutor-8729-thread-1-processing-n:127.0.0.1:60193_)
[n:127.0.0.1:60193_ c:collection1 s:shard1 r:core_node4 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=46, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=27.884765625,
floorSegmentMB=0.353515625, forceMergeDeletesPctAllowed=11.880464942276273,
segmentsPerTier=46.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.5755229268825173
[junit4] 2> 2672566 WARN
(coreLoadExecutor-8729-thread-1-processing-n:127.0.0.1:60193_)
[n:127.0.0.1:60193_ c:collection1 s:shard1 r:core_node4 x:collection1]
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type =
requestHandler,name = /dump,class = DumpRequestHandler,args =
{defaults={a=A,b=B}}}
[junit4] 2> 2672595 INFO
(coreLoadExecutor-8729-thread-1-processing-n:127.0.0.1:60193_)
[n:127.0.0.1:60193_ c:collection1 s:shard1 r:core_node4 x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 2672595 INFO
(coreLoadExecutor-8729-thread-1-processing-n:127.0.0.1:60193_)
[n:127.0.0.1:60193_ c:collection1 s:shard1 r:core_node4 x:collection1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2672596 INFO
(coreLoadExecutor-8729-thread-1-processing-n:127.0.0.1:60193_)
[n:127.0.0.1:60193_ c:collection1 s:shard1 r:core_node4 x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2672597 INFO
(coreLoadExecutor-8729-thread-1-processing-n:127.0.0.1:60193_)
[n:127.0.0.1:60193_ c:collection1 s:shard1 r:core_node4 x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2672597 INFO
(coreLoadExecutor-8729-thread-1-processing-n:127.0.0.1:60193_)
[n:127.0.0.1:60193_ c:collection1 s:shard1 r:core_node4 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 2672599 INFO
(coreLoadExecutor-8729-thread-1-processing-n:127.0.0.1:60193_)
[n:127.0.0.1:60193_ c:collection1 s:shard1 r:core_node4 x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1b39d36[collection1] main]
[junit4] 2> 2672601 INFO
(coreLoadExecutor-8729-thread-1-processing-n:127.0.0.1:60193_)
[n:127.0.0.1:60193_ c:collection1 s:shard1 r:core_node4 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 2672601 INFO
(coreLoadExecutor-8729-thread-1-processing-n:127.0.0.1:60193_)
[n:127.0.0.1:60193_ c:collection1 s:shard1 r:core_node4 x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 2672601 INFO
(coreLoadExecutor-8729-thread-1-processing-n:127.0.0.1:60193_)
[n:127.0.0.1:60193_ c:collection1 s:shard1 r:core_node4 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2672604 INFO
(searcherExecutor-8730-thread-1-processing-n:127.0.0.1:60193_ x:collection1
s:shard1 c:collection1 r:core_node4) [n:127.0.0.1:60193_ c:collection1 s:shard1
r:core_node4 x:collection1] o.a.s.c.SolrCore [collection1] Registered new
searcher Searcher@1b39d36[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2672604 INFO
(coreLoadExecutor-8729-thread-1-processing-n:127.0.0.1:60193_)
[n:127.0.0.1:60193_ c:collection1 s:shard1 r:core_node4 x:collection1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1549698056918663168
[junit4] 2> 2672610 INFO
(coreZkRegister-8724-thread-1-processing-n:127.0.0.1:60193_ x:collection1
s:shard1 c:collection1 r:core_node4) [n:127.0.0.1:60193_ c:collection1 s:shard1
r:core_node4 x:collection1] o.a.s.c.ZkController Core needs to
recover:collection1
[junit4] 2> 2672611 INFO
(updateExecutor-10330-thread-1-processing-n:127.0.0.1:60193_ x:collection1
s:shard1 c:collection1 r:core_node4) [n:127.0.0.1:60193_ c:collection1 s:shard1
r:core_node4 x:collection1] o.a.s.u.DefaultSolrCoreState Running recovery
[junit4] 2> 2672612 INFO
(recoveryExecutor-10331-thread-1-processing-n:127.0.0.1:60193_ x:collection1
s:shard1 c:collection1 r:core_node4) [n:127.0.0.1:60193_ c:collection1 s:shard1
r:core_node4 x:collection1] o.a.s.c.RecoveryStrategy Starting recovery process.
recoveringAfterStartup=true
[junit4] 2> 2672612 INFO
(recoveryExecutor-10331-thread-1-processing-n:127.0.0.1:60193_ x:collection1
s:shard1 c:collection1 r:core_node4) [n:127.0.0.1:60193_ c:collection1 s:shard1
r:core_node4 x:collection1] o.a.s.c.RecoveryStrategy ###### startupVersions=[[]]
[junit4] 2> 2672612 INFO
(recoveryExecutor-10331-thread-1-processing-n:127.0.0.1:60193_ x:collection1
s:shard1 c:collection1 r:core_node4) [n:127.0.0.1:60193_ c:collection1 s:shard1
r:core_node4 x:collection1] o.a.s.c.RecoveryStrategy Begin buffering updates.
core=[collection1]
[junit4] 2> 2672612 INFO
(recoveryExecutor-10331-thread-1-processing-n:127.0.0.1:60193_ x:collection1
s:shard1 c:collection1 r:core_node4) [n:127.0.0.1:60193_ c:collection1 s:shard1
r:core_node4 x:collection1] o.a.s.u.UpdateLog Starting to buffer updates.
FSUpdateLog{state=ACTIVE, tlog=null}
[junit4] 2> 2672612 INFO
(recoveryExecutor-10331-thread-1-processing-n:127.0.0.1:60193_ x:collection1
s:shard1 c:collection1 r:core_node4) [n:127.0.0.1:60193_ c:collection1 s:shard1
r:core_node4 x:collection1] o.a.s.c.RecoveryStrategy Publishing state of core
[collection1] as recovering, leader is [http://127.0.0.1:60143/collection1/]
and I am [http://127.0.0.1:60193/collection1/]
[junit4] 2> 2672616 INFO
(recoveryExecutor-10331-thread-1-processing-n:127.0.0.1:60193_ x:collection1
s:shard1 c:collection1 r:core_node4) [n:127.0.0.1:60193_ c:collection1 s:shard1
r:core_node4 x:collection1] o.a.s.c.RecoveryStrategy Sending prep recovery
command to [http://127.0.0.1:60143]; [WaitForState:
action=PREPRECOVERY&core=collection1&nodeName=127.0.0.1:60193_&coreNodeName=core_node4&state=recovering&checkLive=true&onlyIfLeader=true&onlyIfLeaderActive=true]
[junit4] 2> 2672622 INFO (qtp20103581-43904) [n:127.0.0.1:60143_ ]
o.a.s.h.a.PrepRecoveryOp Going to wait for coreNodeName: core_node4, state:
recovering, checkLive: true, onlyIfLeader: true, onlyIfLeaderActive: true
[junit4] 2> 2672623 INFO (qtp20103581-43904) [n:127.0.0.1:60143_ ]
o.a.s.h.a.PrepRecoveryOp Will wait a max of 183 seconds to see collection1
(shard1 of collection1) have state: recovering
[junit4] 2> 2672623 INFO (qtp20103581-43904) [n:127.0.0.1:60143_ ]
o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): collection=collection1,
shard=shard1, thisCore=collection1, leaderDoesNotNeedRecovery=false, isLeader?
true, live=true, checkLive=true, currentState=down, localState=active,
nodeName=127.0.0.1:60193_, coreNodeName=core_node4,
onlyIfActiveCheckResult=false, nodeProps:
core_node4:{"core":"collection1","base_url":"http://127.0.0.1:60193","node_name":"127.0.0.1:60193_","state":"down"}
[junit4] 2> 2672822 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testDynamicLoading
[junit4] 2> 2672826 INFO
(TEST-TestDynamicLoading.testDynamicLoading-seed#[957680B73009894C]) [ ]
o.a.s.c.TestSolrConfigHandler going to send config command. path
/config?wt=json , payload:
[junit4] 2> 2672836 INFO (qtp990864-43964) [n:127.0.0.1:60193_
c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.h.SolrConfigHandler
Executed config commands successfully and persisted to ZK [{"add-runtimelib":{
[junit4] 2> "name":"colltest",
[junit4] 2> "version":1}}]
[junit4] 2> 2672836 INFO (qtp990864-43964) [n:127.0.0.1:60193_
c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.h.SolrConfigHandler
Waiting up to 30 secs for 2 replicas to set the property overlay to be of
version 0 for collection collection1
[junit4] 2> 2672842 INFO (Thread-3881) [n:127.0.0.1:60193_ ]
o.a.s.c.SolrCore config update listener called for core collection1
[junit4] 2> 2672842 INFO (Thread-3882) [n:127.0.0.1:60143_ ]
o.a.s.c.SolrCore config update listener called for core collection1
[junit4] 2> 2672843 INFO (Thread-3883) [n:127.0.0.1:60086_ ]
o.a.s.c.SolrCore config update listener called for core collection1
[junit4] 2> 2672843 INFO (Thread-3884) [n:127.0.0.1:60119_ ]
o.a.s.c.SolrCore config update listener called for core collection1
[junit4] 2> 2672844 INFO (Thread-3885) [n:127.0.0.1:60167_ ]
o.a.s.c.SolrCore config update listener called for core collection1
[junit4] 2> 2672844 INFO (Thread-3881) [n:127.0.0.1:60193_ ]
o.a.s.s.SchemaManager managed schema loaded . version : 0
[junit4] 2> 2672845 INFO (Thread-3882) [n:127.0.0.1:60143_ ]
o.a.s.s.SchemaManager managed schema loaded . version : 0
[junit4] 2> 2672845 ERROR (Thread-3882) [n:127.0.0.1:60143_ ]
o.a.s.s.IndexSchema This IndexSchema is not mutable.
[junit4] 2> 2672845 ERROR (Thread-3881) [n:127.0.0.1:60193_ ]
o.a.s.s.IndexSchema This IndexSchema is not mutable.
[junit4] 2> 2672845 WARN (Thread-3882) [n:127.0.0.1:60143_ ]
o.a.s.c.SolrCore
[junit4] 2> org.apache.solr.common.SolrException: This IndexSchema is not
mutable.
[junit4] 2> at
org.apache.solr.schema.IndexSchema.getSchemaUpdateLock(IndexSchema.java:1872)
[junit4] 2> at
org.apache.solr.schema.SchemaManager.getFreshManagedSchema(SchemaManager.java:424)
[junit4] 2> at
org.apache.solr.core.SolrCore.lambda$getConfListener$6(SolrCore.java:2699)
[junit4] 2> at
org.apache.solr.cloud.ZkController.lambda$fireEventListeners$4(ZkController.java:2448)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2672845 INFO (Thread-3882) [n:127.0.0.1:60143_ ]
o.a.s.c.SolrCore core reload collection1
[junit4] 2> 2672845 WARN (Thread-3881) [n:127.0.0.1:60193_ ]
o.a.s.c.SolrCore
[junit4] 2> org.apache.solr.common.SolrException: This IndexSchema is not
mutable.
[junit4] 2> at
org.apache.solr.schema.IndexSchema.getSchemaUpdateLock(IndexSchema.java:1872)
[junit4] 2> at
org.apache.solr.schema.SchemaManager.getFreshManagedSchema(SchemaManager.java:424)
[junit4] 2> at
org.apache.solr.core.SolrCore.lambda$getConfListener$6(SolrCore.java:2699)
[junit4] 2> at
org.apache.solr.cloud.ZkController.lambda$fireEventListeners$4(ZkController.java:2448)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2672846 INFO (Thread-3881) [n:127.0.0.1:60193_ ]
o.a.s.c.SolrCore core reload collection1
[junit4] 2> 2672847 INFO (Thread-3883) [n:127.0.0.1:60086_ ]
o.a.s.s.SchemaManager managed schema loaded . version : 0
[junit4] 2> 2672847 ERROR (Thread-3883) [n:127.0.0.1:60086_ ]
o.a.s.s.IndexSchema This IndexSchema is not mutable.
[junit4] 2> 2672847 WARN (Thread-3883) [n:127.0.0.1:60086_ ]
o.a.s.c.SolrCore
[junit4] 2> org.apache.solr.common.SolrException: This IndexSchema is not
mutable.
[junit4] 2> at
org.apache.solr.schema.IndexSchema.getSchemaUpdateLock(IndexSchema.java:1872)
[junit4] 2> at
org.apache.solr.schema.SchemaManager.getFreshManagedSchema(SchemaManager.java:424)
[junit4] 2> at
org.apache.solr.core.SolrCore.lambda$getConfListener$6(SolrCore.java:2699)
[junit4] 2> at
org.apache.solr.cloud.ZkController.lambda$fireEventListeners$4(ZkController.java:2448)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2672847 INFO (Thread-3883) [n:127.0.0.1:60086_ ]
o.a.s.c.SolrCore core reload collection1
[junit4] 2> 2672847 INFO
(solrHandlerExecutor-8735-thread-1-processing-n:127.0.0.1:60193_ x:collection1
s:shard1 c:collection1 r:core_node4) [n:127.0.0.1:60193_ c:collection1 s:shard1
r:core_node4 x:collection1] o.a.s.h.SolrConfigHandler Time elapsed : 0 secs,
maxWait 30
[junit4] 2> 2672848 INFO
(solrHandlerExecutor-8735-thread-2-processing-n:127.0.0.1:60193_ x:collection1
s:shard1 c:collection1 r:core_node4) [n:127.0.0.1:60193_ c:c
[...truncated too long message...]
erver connecting to 127.0.0.1:60067 60067
[junit4] 2> 2709865 WARN (Thread-3831) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 40 /solr/configs/conf1
[junit4] 2> 6 /solr/aliases.json
[junit4] 2> 6 /solr/clusterprops.json
[junit4] 2> 5 /solr/security.json
[junit4] 2> 4 /solr/collections/collection1/state.json
[junit4] 2> 2 /solr/configs/.system
[junit4] 2> 2 /solr/configs/.system/managed-schema
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 6 /solr/clusterstate.json
[junit4] 2> 2 /solr/collections/.system/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 50 /solr/overseer/queue
[junit4] 2> 42 /solr/overseer/collection-queue-work
[junit4] 2> 11 /solr/overseer/queue-work
[junit4] 2> 6 /solr/live_nodes
[junit4] 2> 6 /solr/collections
[junit4] 2>
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestDynamicLoading
-Dtests.method=testDynamicLoading -Dtests.seed=957680B73009894C
-Dtests.slow=true -Dtests.locale=en-SG -Dtests.timezone=Europe/Volgograd
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] FAILURE 48.9s J0 | TestDynamicLoading.testDynamicLoading <<<
[junit4] > Throwable #1: java.lang.AssertionError: Could not get expected
value 'X val changed' for path 'x' full output: {
[junit4] > "responseHeader":{
[junit4] > "status":0,
[junit4] > "QTime":0},
[junit4] > "params":{"wt":"json"},
[junit4] > "context":{
[junit4] > "webapp":"",
[junit4] > "path":"/test1",
[junit4] > "httpMethod":"GET"},
[junit4] > "class":"org.apache.solr.core.BlobStoreTestRequestHandler",
[junit4] > "x":"X val"}, from server: null
[junit4] > at
__randomizedtesting.SeedInfo.seed([957680B73009894C:4D3BADE0C7D42CEC]:0)
[junit4] > at
org.apache.solr.core.TestSolrConfigHandler.testForResponseElement(TestSolrConfigHandler.java:535)
[junit4] > at
org.apache.solr.core.TestDynamicLoading.testDynamicLoading(TestDynamicLoading.java:249)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2709869 INFO
(SUITE-TestDynamicLoading-seed#[957680B73009894C]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestDynamicLoading_957680B73009894C-001
[junit4] 2> Oct 31, 2016 9:47:52 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62):
{blobName=PostingsFormat(name=Memory doPackFST= false), size=FSTOrd50,
_version_=PostingsFormat(name=LuceneFixedGap), id=Lucene50(blocksize=128),
version=PostingsFormat(name=Memory doPackFST= false),
md5=PostingsFormat(name=LuceneFixedGap),
timestamp=PostingsFormat(name=LuceneFixedGap)}, docValues:{},
maxPointsInLeafNode=356, maxMBSortInHeap=7.189452687204673,
sim=ClassicSimilarity, locale=en-SG, timezone=Europe/Volgograd
[junit4] 2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_102
(32-bit)/cpus=3,threads=1,free=85115248,total=395051008
[junit4] 2> NOTE: All tests run in this JVM: [TestCorePropertiesReload,
LeaderElectionContextKeyTest, TestManagedSchemaAPI, TestBinaryField,
PingRequestHandlerTest, HdfsThreadLeakTest, MoreLikeThisHandlerTest,
TestFieldTypeResource, TestUninvertingReader, TestInfoStreamLogging,
GraphQueryTest, TestFunctionQuery, BadComponentTest,
AnalysisAfterCoreReloadTest, TestSQLHandlerNonCloud, TestSSLRandomization,
TestDownShardTolerantSearch, AddSchemaFieldsUpdateProcessorFactoryTest,
TestSort, SaslZkACLProviderTest, ExitableDirectoryReaderTest,
TestGroupingSearch, BlockCacheTest, EnumFieldTest, RollingRestartTest,
TestReplicationHandlerBackup, TestConfigReload, TestMiniSolrCloudCluster,
TestCollationFieldDocValues, TestFieldCacheSanityChecker,
TestDefaultStatsCache, TestStandardQParsers, SortSpecParsingTest,
SynonymTokenizerTest, TestPseudoReturnFields, TestIBSimilarityFactory,
HighlighterMaxOffsetTest, ParsingFieldUpdateProcessorsTest,
TestConfigSetProperties, FastVectorHighlighterTest,
TestPartialUpdateDeduplication, TestFieldCacheWithThreads,
CdcrReplicationDistributedZkTest, IndexSchemaRuntimeFieldTest, InfoHandlerTest,
TestLFUCache, TestFieldResource, TestJmxIntegration, ShardRoutingTest,
TestCoreContainer, TestTolerantUpdateProcessorRandomCloud, HLLUtilTest,
TestScoreJoinQPScore, BlockJoinFacetRandomTest, DirectSolrSpellCheckerTest,
FullHLLTest, CustomCollectionTest, TestFieldCache, MergeStrategyTest,
TestCloudInspectUtil, HdfsRecoverLeaseTest, DateFieldTest,
DistributedFacetPivotSmallTest, OpenExchangeRatesOrgProviderTest,
TestUniqueKeyFieldResource, CoreAdminRequestStatusTest, TestStressReorder,
TestTrieFacet, TestStressLiveNodes, TestRemoteStreaming,
TestSolrCloudSnapshots, ClassificationUpdateProcessorFactoryTest,
TestStressLucene, DistributedQueryComponentCustomSortTest, ZkNodePropsTest,
TestAnalyzedSuggestions, TestHdfsCloudBackupRestore, ForceLeaderTest,
TestBulkSchemaConcurrent, ReplicationFactorTest,
SharedFSAutoReplicaFailoverTest, DisMaxRequestHandlerTest, DOMUtilTest,
TestLRUCache, HdfsChaosMonkeyNothingIsSafeTest, TestHighlightDedupGrouping,
TestSizeLimitedDistributedMap, RecoveryZkTest, TestStressVersions, TestRTGBase,
DistributedFacetPivotLongTailTest, TestCloudPseudoReturnFields,
TestSolrConfigHandlerConcurrent, DistributedFacetExistsSmallTest,
TestStressRecovery, TemplateUpdateProcessorTest, OutputWriterTest,
TestRestoreCore, DeleteStatusTest, SolrCoreTest, TimeZoneUtilsTest,
TestGraphTermsQParserPlugin, DirectUpdateHandlerTest, TestFieldSortValues,
TestPKIAuthenticationPlugin, UnloadDistributedZkTest,
TestLocalFSCloudBackupRestore, PluginInfoTest,
TestOverriddenPrefixQueryForCustomFieldType, TestPerFieldSimilarity,
PeerSyncTest, DirectSolrConnectionTest, TestCursorMarkWithoutUniqueKey,
MultiThreadedOCPTest, LeaderFailureAfterFreshStartTest,
OverseerModifyCollectionTest, DistanceUnitsTest, DateRangeFieldTest,
TestFastOutputStream, TestDocBasedVersionConstraints,
CollectionStateFormat2Test, LeaderInitiatedRecoveryOnShardRestartTest,
AssignTest, AnalysisErrorHandlingTest, SyncSliceTest, TestRestManager,
TestGeoJSONResponseWriter, MultiTermTest, TestDefaultSearchFieldResource,
StressHdfsTest, TestConfigSetsAPIZkFailure, TestPhraseSuggestions,
TestRawResponseWriter, TestExtendedDismaxParser, ChaosMonkeyNothingIsSafeTest,
DocValuesTest, TestCollationField, TestManagedResource, HighlighterTest,
QueryResultKeyTest, BufferStoreTest, PKIAuthenticationIntegrationTest,
OverseerStatusTest, BitVectorTest, CurrencyFieldXmlFileTest,
PrimitiveFieldTypeTest, RemoteQueryErrorTest, HdfsUnloadDistributedZkTest,
SimpleFacetsTest, DistributedQueueTest, TestHashPartitioner, TestUpdate,
DistribDocExpirationUpdateProcessorTest, LeaderElectionTest,
PathHierarchyTokenizerFactoryTest, DocumentAnalysisRequestHandlerTest,
TestFaceting, DistributedSpellCheckComponentTest, TestJoin, TestRangeQuery,
StatsComponentTest, BasicFunctionalityTest, TestBadConfig, SoftAutoCommitTest,
DistributedQueryElevationComponentTest, SuggesterTSTTest, TestTrie,
TestCSVLoader, SchemaVersionSpecificBehaviorTest, QueryEqualityTest,
SortByFunctionTest, DocValuesMultiTest, TestSolrDeletionPolicy1,
DebugComponentTest, IndexBasedSpellCheckerTest, TestQueryUtils,
StandardRequestHandlerTest, TestWriterPerf, TermsComponentTest,
DocumentBuilderTest, TermVectorComponentTest, SolrPluginUtilsTest,
JSONWriterTest, UniqFieldsUpdateProcessorFactoryTest,
TestPHPSerializedResponseWriter, TestComponentsName, TestBinaryResponseWriter,
SOLR749Test, TestQuerySenderListener, AlternateDirectoryTest,
TestSolrIndexConfig, CopyFieldTest, ResponseLogComponentTest,
SolrIndexConfigTest, TestMergePolicyConfig, NumericFieldsTest,
TestFuzzyAnalyzedSuggestions, TestPostingsSolrHighlighter, TestCharFilters,
EchoParamsTest, TestDFRSimilarityFactory, TestBM25SimilarityFactory,
TestFastLRUCache, PreAnalyzedFieldTest, TestSuggestSpellingConverter,
TestSolrJ, TestDocumentBuilder, CursorPagingTest,
TestSimpleTrackingShardHandler, TestTolerantSearch, ActionThrottleTest,
BaseCdcrDistributedZkTest, CdcrBootstrapTest,
CollectionsAPIAsyncDistributedZkTest, ConcurrentDeleteAndCreateCollectionTest,
ConnectionManagerTest, DeleteLastCustomShardedReplicaTest, DeleteShardTest,
LeaderFailoverAfterPartitionTest, LeaderInitiatedRecoveryOnCommitTest,
OutOfBoxZkACLAndCredentialsProvidersTest,
OverriddenZkACLAndCredentialsProvidersTest, OverseerTaskQueueTest,
PeerSyncReplicationTest, TestAuthenticationFramework, TestClusterProperties,
TestConfigSetsAPI, TestDeleteCollectionOnDownNodes,
TestExclusionRuleCollectionAccess, TestLeaderElectionZkExpiry, TestLockTree,
TestMiniSolrCloudClusterSSL, TestRequestForwarding, TestShortCircuitedRequests,
TestSolrCloudWithKerberosAlt, VMParamsZkACLAndCredentialsProvidersTest,
HdfsBasicDistributedZk2Test, HdfsBasicDistributedZkTest,
HdfsChaosMonkeySafeLeaderTest, HdfsCollectionsAPIDistributedZkTest,
HdfsRestartWhileUpdatingTest, HdfsWriteToMultipleCollectionsTest,
TestClusterStateMutator, ZkStateReaderTest, ZkStateWriterTest, RulesTest,
TestDynamicLoading]
[junit4] Completed [530/648 (1!)] on J0 in 49.76s, 1 test, 1 failure <<<
FAILURES!
[...truncated 53068 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
