Build: https://builds.apache.org/job/Lucene-Solr-Tests-6.x/463/
3 tests failed.
FAILED: org.apache.solr.cloud.BasicDistributedZkTest.test
Error Message:
Test abandoned because suite timeout was reached.
Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
at __randomizedtesting.SeedInfo.seed([B02B01C054FBF51D]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.BasicDistributedZkTest
Error Message:
Suite timeout exceeded (>= 7200000 msec).
Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
at __randomizedtesting.SeedInfo.seed([B02B01C054FBF51D]:0)
FAILED: org.apache.solr.cloud.CdcrVersionReplicationTest.testCdcrDocVersions
Error Message:
Stack Trace:
org.apache.solr.common.cloud.ZooKeeperException:
at
__randomizedtesting.SeedInfo.seed([B02B01C054FBF51D:48BD0A62A69D1A01]:0)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.connect(CloudSolrClient.java:576)
at
org.apache.solr.cloud.BaseCdcrDistributedZkTest.waitForCollectionToDisappear(BaseCdcrDistributedZkTest.java:494)
at
org.apache.solr.cloud.BaseCdcrDistributedZkTest.startServers(BaseCdcrDistributedZkTest.java:596)
at
org.apache.solr.cloud.BaseCdcrDistributedZkTest.createSourceCollection(BaseCdcrDistributedZkTest.java:346)
at
org.apache.solr.cloud.BaseCdcrDistributedZkTest.baseBefore(BaseCdcrDistributedZkTest.java:168)
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:1764)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:905)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
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:809)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
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)
Caused by: org.apache.zookeeper.KeeperException$SessionExpiredException:
KeeperErrorCode = Session expired for /clusterstate.json
at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
at org.apache.zookeeper.ZooKeeper.exists(ZooKeeper.java:1045)
at
org.apache.solr.common.cloud.SolrZkClient$5.execute(SolrZkClient.java:322)
at
org.apache.solr.common.cloud.SolrZkClient$5.execute(SolrZkClient.java:319)
at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
at
org.apache.solr.common.cloud.SolrZkClient.exists(SolrZkClient.java:319)
at
org.apache.solr.common.cloud.ZkStateReader.createClusterStateWatchersAndUpdate(ZkStateReader.java:374)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.connect(CloudSolrClient.java:568)
... 44 more
Build Log:
[...truncated 11877 lines...]
[junit4] Suite: org.apache.solr.cloud.CdcrVersionReplicationTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/init-core-data-001
[junit4] 2> 2663968 INFO
(SUITE-CdcrVersionReplicationTest-seed#[B02B01C054FBF51D]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 2663969 INFO
(SUITE-CdcrVersionReplicationTest-seed#[B02B01C054FBF51D]-worker) [ ]
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 2663971 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2663971 INFO (Thread-5149) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2663972 INFO (Thread-5149) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 2664071 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.ZkTestServer start zk server on port:46256
[junit4] 2> 2664100 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-cdcr.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 2664107 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/core/src/test-files/solr/collection1/conf/schema15.xml
to /configs/conf1/schema.xml
[junit4] 2> 2664109 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 2664116 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 2664117 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 2664123 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 2664125 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 2664126 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 2664131 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 2664132 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 2664133 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 2664145 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.SolrTestCaseJ4 ###Starting testCdcrDocVersions
[junit4] 2> 2664518 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-001/cores/collection1
[junit4] 2> 2664521 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 2664532 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@45eadd3b{/,null,AVAILABLE}
[junit4] 2> 2664535 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.e.j.s.ServerConnector Started ServerConnector@5dc4140e{SSL,[ssl,
http/1.1]}{127.0.0.1:37240}
[junit4] 2> 2664535 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.e.j.s.Server Started @2672623ms
[junit4] 2> 2664535 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.s.e.JettySolrRunner Jetty properties: {shards=shard1,
hostContext=/, hostPort=37240,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-001/cores}
[junit4] 2> 2664535 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™
version 6.3.0
[junit4] 2> 2664535 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on
port null
[junit4] 2> 2664535 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2664535 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-10-04T13:55:04.491Z
[junit4] 2> 2664563 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 2664563 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-001/solr.xml
[junit4] 2> 2664586 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with
params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 2664594 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46256/solr
[junit4] 2> 2664624 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D])
[n:127.0.0.1:37240_ ] o.a.s.c.OverseerElectionContext I am going to be the
leader 127.0.0.1:37240_
[junit4] 2> 2664625 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D])
[n:127.0.0.1:37240_ ] o.a.s.c.Overseer Overseer
(id=96704220622290949-127.0.0.1:37240_-n_0000000000) starting
[junit4] 2> 2664635 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D])
[n:127.0.0.1:37240_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:37240_
[junit4] 2> 2664647 INFO
(OverseerStateUpdate-96704220622290949-127.0.0.1:37240_-n_0000000000)
[n:127.0.0.1:37240_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 2664668 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D])
[n:127.0.0.1:37240_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-001/cores
[junit4] 2> 2664668 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D])
[n:127.0.0.1:37240_ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 2664695 INFO
(OverseerStateUpdate-96704220622290949-127.0.0.1:37240_-n_0000000000)
[n:127.0.0.1:37240_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard2
[junit4] 2> 2665734 INFO
(coreLoadExecutor-7411-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ c:tmp_collection x:collection1] o.a.s.c.ZkController Only
one config set found in zk - using it:conf1
[junit4] 2> 2665745 WARN
(coreLoadExecutor-7411-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ c:tmp_collection x:collection1] o.a.s.c.Config Beginning
with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 2665746 INFO
(coreLoadExecutor-7411-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ c:tmp_collection x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 6.3.0
[junit4] 2> 2665766 INFO
(coreLoadExecutor-7411-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ c:tmp_collection x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 2666030 WARN
(coreLoadExecutor-7411-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ c:tmp_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> 2666031 INFO
(coreLoadExecutor-7411-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ c:tmp_collection x:collection1] o.a.s.s.IndexSchema
Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 2666050 INFO
(coreLoadExecutor-7411-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ c:tmp_collection x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
tmp_collection
[junit4] 2> 2666050 INFO
(coreLoadExecutor-7411-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-001/cores/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-001/cores/collection1/data/]
[junit4] 2> 2666050 INFO
(coreLoadExecutor-7411-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ c:tmp_collection 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@1a9eaf15
[junit4] 2> 2666051 INFO
(coreLoadExecutor-7411-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=46, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=36.099609375,
floorSegmentMB=1.9326171875, forceMergeDeletesPctAllowed=1.7175272038539502,
segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 2666067 INFO
(coreLoadExecutor-7411-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.CdcrUpdateLog
[junit4] 2> 2666067 INFO
(coreLoadExecutor-7411-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ c:tmp_collection 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> 2666068 INFO
(coreLoadExecutor-7411-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2666068 INFO
(coreLoadExecutor-7411-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2666075 INFO
(coreLoadExecutor-7411-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=25, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 2666075 INFO
(coreLoadExecutor-7411-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@37ac6f0b[collection1] main]
[junit4] 2> 2666076 INFO
(coreLoadExecutor-7411-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 2666077 INFO
(coreLoadExecutor-7411-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ c:tmp_collection 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> 2666077 INFO
(coreLoadExecutor-7411-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2666080 INFO
(coreLoadExecutor-7411-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.h.CdcrBufferStateManager Created znode
/collections/tmp_collection/cdcr/state/buffer
[junit4] 2> 2666081 INFO
(coreLoadExecutor-7411-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.h.CdcrProcessStateManager Created znode
/collections/tmp_collection/cdcr/state/process
[junit4] 2> 2666083 INFO
(coreLoadExecutor-7411-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ c:tmp_collection 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 1547267532169150464
[junit4] 2> 2666086 INFO
(searcherExecutor-7412-thread-1-processing-n:127.0.0.1:37240_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:37240_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered
new searcher Searcher@37ac6f0b[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2666096 INFO
(coreZkRegister-7404-thread-1-processing-n:127.0.0.1:37240_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:37240_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough
replicas found to continue.
[junit4] 2> 2666096 INFO
(coreZkRegister-7404-thread-1-processing-n:127.0.0.1:37240_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:37240_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I may
be the new leader - try and sync
[junit4] 2> 2666096 INFO
(coreZkRegister-7404-thread-1-processing-n:127.0.0.1:37240_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:37240_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:37240/collection1/
[junit4] 2> 2666096 INFO
(coreZkRegister-7404-thread-1-processing-n:127.0.0.1:37240_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:37240_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now
sync replicas to me
[junit4] 2> 2666096 INFO
(coreZkRegister-7404-thread-1-processing-n:127.0.0.1:37240_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:37240_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
https://127.0.0.1:37240/collection1/ has no replicas
[junit4] 2> 2666121 INFO
(coreZkRegister-7404-thread-1-processing-n:127.0.0.1:37240_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:37240_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I am
the new leader: https://127.0.0.1:37240/collection1/ shard2
[junit4] 2> 2666124 INFO
(zkCallback-18182-thread-2-processing-n:127.0.0.1:37240_) [n:127.0.0.1:37240_
] o.a.s.h.CdcrLeaderStateManager Received new leader state @
tmp_collection:shard2
[junit4] 2> 2666278 INFO
(coreZkRegister-7404-thread-1-processing-n:127.0.0.1:37240_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:37240_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no
recovery necessary
[junit4] 2> 2666334 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-002/cores/collection1
[junit4] 2> 2666353 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 2666356 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1594f0a7{/,null,AVAILABLE}
[junit4] 2> 2666357 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.e.j.s.ServerConnector Started ServerConnector@7aab2f5a{SSL,[ssl,
http/1.1]}{127.0.0.1:33122}
[junit4] 2> 2666357 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.e.j.s.Server Started @2674446ms
[junit4] 2> 2666357 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.s.e.JettySolrRunner Jetty properties: {shards=shard2,
hostContext=/, hostPort=33122,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-002/cores}
[junit4] 2> 2666358 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™
version 6.3.0
[junit4] 2> 2666358 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on
port null
[junit4] 2> 2666358 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2666358 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-10-04T13:55:06.314Z
[junit4] 2> 2666394 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 2666395 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-002/solr.xml
[junit4] 2> 2666401 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with
params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 2666402 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46256/solr
[junit4] 2> 2666618 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D])
[n:127.0.0.1:33122_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 2666646 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D])
[n:127.0.0.1:33122_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:33122_
[junit4] 2> 2666669 INFO
(zkCallback-18182-thread-5-processing-n:127.0.0.1:37240_) [n:127.0.0.1:37240_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2666673 INFO
(zkCallback-18188-thread-1-processing-n:127.0.0.1:33122_) [n:127.0.0.1:33122_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2666688 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D])
[n:127.0.0.1:33122_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-002/cores
[junit4] 2> 2666688 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D])
[n:127.0.0.1:33122_ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 2666703 INFO
(OverseerStateUpdate-96704220622290949-127.0.0.1:37240_-n_0000000000)
[n:127.0.0.1:37240_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 2667701 WARN
(coreLoadExecutor-7423-thread-1-processing-n:127.0.0.1:33122_)
[n:127.0.0.1:33122_ c:tmp_collection x:collection1] o.a.s.c.Config Beginning
with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 2667702 INFO
(coreLoadExecutor-7423-thread-1-processing-n:127.0.0.1:33122_)
[n:127.0.0.1:33122_ c:tmp_collection x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 6.3.0
[junit4] 2> 2667718 INFO
(coreLoadExecutor-7423-thread-1-processing-n:127.0.0.1:33122_)
[n:127.0.0.1:33122_ c:tmp_collection x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 2667896 WARN
(coreLoadExecutor-7423-thread-1-processing-n:127.0.0.1:33122_)
[n:127.0.0.1:33122_ c:tmp_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> 2667898 INFO
(coreLoadExecutor-7423-thread-1-processing-n:127.0.0.1:33122_)
[n:127.0.0.1:33122_ c:tmp_collection x:collection1] o.a.s.s.IndexSchema
Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 2667915 INFO
(coreLoadExecutor-7423-thread-1-processing-n:127.0.0.1:33122_)
[n:127.0.0.1:33122_ c:tmp_collection x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
tmp_collection
[junit4] 2> 2667916 INFO
(coreLoadExecutor-7423-thread-1-processing-n:127.0.0.1:33122_)
[n:127.0.0.1:33122_ c:tmp_collection s:shard1 r:core_node2 x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-002/cores/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-002/cores/collection1/data/]
[junit4] 2> 2667916 INFO
(coreLoadExecutor-7423-thread-1-processing-n:127.0.0.1:33122_)
[n:127.0.0.1:33122_ c:tmp_collection 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@1a9eaf15
[junit4] 2> 2667917 INFO
(coreLoadExecutor-7423-thread-1-processing-n:127.0.0.1:33122_)
[n:127.0.0.1:33122_ c:tmp_collection s:shard1 r:core_node2 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=46, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=36.099609375,
floorSegmentMB=1.9326171875, forceMergeDeletesPctAllowed=1.7175272038539502,
segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 2667947 INFO
(coreLoadExecutor-7423-thread-1-processing-n:127.0.0.1:33122_)
[n:127.0.0.1:33122_ c:tmp_collection s:shard1 r:core_node2 x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.CdcrUpdateLog
[junit4] 2> 2667947 INFO
(coreLoadExecutor-7423-thread-1-processing-n:127.0.0.1:33122_)
[n:127.0.0.1:33122_ c:tmp_collection 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> 2667948 INFO
(coreLoadExecutor-7423-thread-1-processing-n:127.0.0.1:33122_)
[n:127.0.0.1:33122_ c:tmp_collection s:shard1 r:core_node2 x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2667948 INFO
(coreLoadExecutor-7423-thread-1-processing-n:127.0.0.1:33122_)
[n:127.0.0.1:33122_ c:tmp_collection s:shard1 r:core_node2 x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2667955 INFO
(coreLoadExecutor-7423-thread-1-processing-n:127.0.0.1:33122_)
[n:127.0.0.1:33122_ c:tmp_collection s:shard1 r:core_node2 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=25, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 2667955 INFO
(coreLoadExecutor-7423-thread-1-processing-n:127.0.0.1:33122_)
[n:127.0.0.1:33122_ c:tmp_collection s:shard1 r:core_node2 x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1d4ebbbe[collection1] main]
[junit4] 2> 2667969 INFO
(coreLoadExecutor-7423-thread-1-processing-n:127.0.0.1:33122_)
[n:127.0.0.1:33122_ c:tmp_collection s:shard1 r:core_node2 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 2667974 INFO
(coreLoadExecutor-7423-thread-1-processing-n:127.0.0.1:33122_)
[n:127.0.0.1:33122_ c:tmp_collection 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> 2667975 INFO
(coreLoadExecutor-7423-thread-1-processing-n:127.0.0.1:33122_)
[n:127.0.0.1:33122_ c:tmp_collection s:shard1 r:core_node2 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2668011 INFO
(searcherExecutor-7424-thread-1-processing-n:127.0.0.1:33122_ x:collection1
s:shard1 c:tmp_collection r:core_node2) [n:127.0.0.1:33122_ c:tmp_collection
s:shard1 r:core_node2 x:collection1] o.a.s.c.SolrCore [collection1] Registered
new searcher Searcher@1d4ebbbe[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2668011 INFO
(coreLoadExecutor-7423-thread-1-processing-n:127.0.0.1:33122_)
[n:127.0.0.1:33122_ c:tmp_collection 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 1547267534190804992
[junit4] 2> 2668043 INFO
(coreZkRegister-7418-thread-1-processing-n:127.0.0.1:33122_ x:collection1
s:shard1 c:tmp_collection r:core_node2) [n:127.0.0.1:33122_ c:tmp_collection
s:shard1 r:core_node2 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough
replicas found to continue.
[junit4] 2> 2668043 INFO
(coreZkRegister-7418-thread-1-processing-n:127.0.0.1:33122_ x:collection1
s:shard1 c:tmp_collection r:core_node2) [n:127.0.0.1:33122_ c:tmp_collection
s:shard1 r:core_node2 x:collection1] o.a.s.c.ShardLeaderElectionContext I may
be the new leader - try and sync
[junit4] 2> 2668043 INFO
(coreZkRegister-7418-thread-1-processing-n:127.0.0.1:33122_ x:collection1
s:shard1 c:tmp_collection r:core_node2) [n:127.0.0.1:33122_ c:tmp_collection
s:shard1 r:core_node2 x:collection1] o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:33122/collection1/
[junit4] 2> 2668043 INFO
(coreZkRegister-7418-thread-1-processing-n:127.0.0.1:33122_ x:collection1
s:shard1 c:tmp_collection r:core_node2) [n:127.0.0.1:33122_ c:tmp_collection
s:shard1 r:core_node2 x:collection1] o.a.s.c.SyncStrategy Sync Success - now
sync replicas to me
[junit4] 2> 2668044 INFO
(coreZkRegister-7418-thread-1-processing-n:127.0.0.1:33122_ x:collection1
s:shard1 c:tmp_collection r:core_node2) [n:127.0.0.1:33122_ c:tmp_collection
s:shard1 r:core_node2 x:collection1] o.a.s.c.SyncStrategy
https://127.0.0.1:33122/collection1/ has no replicas
[junit4] 2> 2668048 INFO
(zkCallback-18188-thread-1-processing-n:127.0.0.1:33122_) [n:127.0.0.1:33122_
] o.a.s.h.CdcrLeaderStateManager Received new leader state @
tmp_collection:shard1
[junit4] 2> 2668060 INFO
(coreZkRegister-7418-thread-1-processing-n:127.0.0.1:33122_ x:collection1
s:shard1 c:tmp_collection r:core_node2) [n:127.0.0.1:33122_ c:tmp_collection
s:shard1 r:core_node2 x:collection1] o.a.s.c.ShardLeaderElectionContext I am
the new leader: https://127.0.0.1:33122/collection1/ shard1
[junit4] 2> 2668222 INFO
(coreZkRegister-7418-thread-1-processing-n:127.0.0.1:33122_ x:collection1
s:shard1 c:tmp_collection r:core_node2) [n:127.0.0.1:33122_ c:tmp_collection
s:shard1 r:core_node2 x:collection1] o.a.s.c.ZkController I am the leader, no
recovery necessary
[junit4] 2> 2668437 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-003/cores/collection1
[junit4] 2> 2668440 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 2668444 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7a08d570{/,null,AVAILABLE}
[junit4] 2> 2668445 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.e.j.s.ServerConnector Started ServerConnector@2ebfae1d{SSL,[ssl,
http/1.1]}{127.0.0.1:52895}
[junit4] 2> 2668445 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.e.j.s.Server Started @2676534ms
[junit4] 2> 2668445 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.s.e.JettySolrRunner Jetty properties: {shards=shard3,
hostContext=/, hostPort=52895,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-003/cores}
[junit4] 2> 2668446 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™
version 6.3.0
[junit4] 2> 2668446 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on
port null
[junit4] 2> 2668446 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2668446 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-10-04T13:55:08.402Z
[junit4] 2> 2668459 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 2668459 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-003/solr.xml
[junit4] 2> 2668466 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with
params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 2668467 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46256/solr
[junit4] 2> 2668495 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D])
[n:127.0.0.1:52895_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 2668499 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D])
[n:127.0.0.1:52895_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:52895_
[junit4] 2> 2668500 INFO
(zkCallback-18188-thread-1-processing-n:127.0.0.1:33122_) [n:127.0.0.1:33122_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2668510 INFO
(zkCallback-18182-thread-5-processing-n:127.0.0.1:37240_) [n:127.0.0.1:37240_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2668511 INFO
(zkCallback-18194-thread-1-processing-n:127.0.0.1:52895_) [n:127.0.0.1:52895_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2668519 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D])
[n:127.0.0.1:52895_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-003/cores
[junit4] 2> 2668519 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D])
[n:127.0.0.1:52895_ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 2668526 INFO
(OverseerStateUpdate-96704220622290949-127.0.0.1:37240_-n_0000000000)
[n:127.0.0.1:37240_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard2
[junit4] 2> 2669554 WARN
(coreLoadExecutor-7435-thread-1-processing-n:127.0.0.1:52895_)
[n:127.0.0.1:52895_ c:tmp_collection x:collection1] o.a.s.c.Config Beginning
with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 2669556 INFO
(coreLoadExecutor-7435-thread-1-processing-n:127.0.0.1:52895_)
[n:127.0.0.1:52895_ c:tmp_collection x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 6.3.0
[junit4] 2> 2669589 INFO
(coreLoadExecutor-7435-thread-1-processing-n:127.0.0.1:52895_)
[n:127.0.0.1:52895_ c:tmp_collection x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 2669766 WARN
(coreLoadExecutor-7435-thread-1-processing-n:127.0.0.1:52895_)
[n:127.0.0.1:52895_ c:tmp_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> 2669767 INFO
(coreLoadExecutor-7435-thread-1-processing-n:127.0.0.1:52895_)
[n:127.0.0.1:52895_ c:tmp_collection x:collection1] o.a.s.s.IndexSchema
Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 2669791 INFO
(coreLoadExecutor-7435-thread-1-processing-n:127.0.0.1:52895_)
[n:127.0.0.1:52895_ c:tmp_collection x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
tmp_collection
[junit4] 2> 2669803 INFO
(coreLoadExecutor-7435-thread-1-processing-n:127.0.0.1:52895_)
[n:127.0.0.1:52895_ c:tmp_collection s:shard2 r:core_node3 x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-003/cores/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-003/cores/collection1/data/]
[junit4] 2> 2669803 INFO
(coreLoadExecutor-7435-thread-1-processing-n:127.0.0.1:52895_)
[n:127.0.0.1:52895_ c:tmp_collection 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@1a9eaf15
[junit4] 2> 2669804 INFO
(coreLoadExecutor-7435-thread-1-processing-n:127.0.0.1:52895_)
[n:127.0.0.1:52895_ c:tmp_collection s:shard2 r:core_node3 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=46, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=36.099609375,
floorSegmentMB=1.9326171875, forceMergeDeletesPctAllowed=1.7175272038539502,
segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 2669839 INFO
(coreLoadExecutor-7435-thread-1-processing-n:127.0.0.1:52895_)
[n:127.0.0.1:52895_ c:tmp_collection s:shard2 r:core_node3 x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.CdcrUpdateLog
[junit4] 2> 2669839 INFO
(coreLoadExecutor-7435-thread-1-processing-n:127.0.0.1:52895_)
[n:127.0.0.1:52895_ c:tmp_collection 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> 2669840 INFO
(coreLoadExecutor-7435-thread-1-processing-n:127.0.0.1:52895_)
[n:127.0.0.1:52895_ c:tmp_collection s:shard2 r:core_node3 x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2669840 INFO
(coreLoadExecutor-7435-thread-1-processing-n:127.0.0.1:52895_)
[n:127.0.0.1:52895_ c:tmp_collection s:shard2 r:core_node3 x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2669851 INFO
(coreLoadExecutor-7435-thread-1-processing-n:127.0.0.1:52895_)
[n:127.0.0.1:52895_ c:tmp_collection s:shard2 r:core_node3 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=25, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 2669851 INFO
(coreLoadExecutor-7435-thread-1-processing-n:127.0.0.1:52895_)
[n:127.0.0.1:52895_ c:tmp_collection s:shard2 r:core_node3 x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@2bc41186[collection1] main]
[junit4] 2> 2669852 INFO
(coreLoadExecutor-7435-thread-1-processing-n:127.0.0.1:52895_)
[n:127.0.0.1:52895_ c:tmp_collection s:shard2 r:core_node3 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 2669853 INFO
(coreLoadExecutor-7435-thread-1-processing-n:127.0.0.1:52895_)
[n:127.0.0.1:52895_ c:tmp_collection 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> 2669853 INFO
(coreLoadExecutor-7435-thread-1-processing-n:127.0.0.1:52895_)
[n:127.0.0.1:52895_ c:tmp_collection s:shard2 r:core_node3 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2669855 INFO
(coreLoadExecutor-7435-thread-1-processing-n:127.0.0.1:52895_)
[n:127.0.0.1:52895_ c:tmp_collection 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 1547267536124379136
[junit4] 2> 2669858 INFO
(searcherExecutor-7436-thread-1-processing-n:127.0.0.1:52895_ x:collection1
s:shard2 c:tmp_collection r:core_node3) [n:127.0.0.1:52895_ c:tmp_collection
s:shard2 r:core_node3 x:collection1] o.a.s.c.SolrCore [collection1] Registered
new searcher Searcher@2bc41186[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2669861 INFO
(coreZkRegister-7430-thread-1-processing-n:127.0.0.1:52895_ x:collection1
s:shard2 c:tmp_collection r:core_node3) [n:127.0.0.1:52895_ c:tmp_collection
s:shard2 r:core_node3 x:collection1] o.a.s.c.ZkController Core needs to
recover:collection1
[junit4] 2> 2669875 INFO
(updateExecutor-18191-thread-1-processing-n:127.0.0.1:52895_ x:collection1
s:shard2 c:tmp_collection r:core_node3) [n:127.0.0.1:52895_ c:tmp_collection
s:shard2 r:core_node3 x:collection1] o.a.s.u.DefaultSolrCoreState Running
recovery
[junit4] 2> 2669895 INFO
(recoveryExecutor-18192-thread-1-processing-n:127.0.0.1:52895_ x:collection1
s:shard2 c:tmp_collection r:core_node3) [n:127.0.0.1:52895_ c:tmp_collection
s:shard2 r:core_node3 x:collection1] o.a.s.c.RecoveryStrategy Starting recovery
process. recoveringAfterStartup=true
[junit4] 2> 2669895 INFO
(recoveryExecutor-18192-thread-1-processing-n:127.0.0.1:52895_ x:collection1
s:shard2 c:tmp_collection r:core_node3) [n:127.0.0.1:52895_ c:tmp_collection
s:shard2 r:core_node3 x:collection1] o.a.s.c.RecoveryStrategy ######
startupVersions=[[]]
[junit4] 2> 2669895 INFO
(recoveryExecutor-18192-thread-1-processing-n:127.0.0.1:52895_ x:collection1
s:shard2 c:tmp_collection r:core_node3) [n:127.0.0.1:52895_ c:tmp_collection
s:shard2 r:core_node3 x:collection1] o.a.s.c.RecoveryStrategy Begin buffering
updates. core=[collection1]
[junit4] 2> 2669895 INFO
(recoveryExecutor-18192-thread-1-processing-n:127.0.0.1:52895_ x:collection1
s:shard2 c:tmp_collection r:core_node3) [n:127.0.0.1:52895_ c:tmp_collection
s:shard2 r:core_node3 x:collection1] o.a.s.u.UpdateLog Starting to buffer
updates. FSUpdateLog{state=ACTIVE, tlog=null}
[junit4] 2> 2669895 INFO
(recoveryExecutor-18192-thread-1-processing-n:127.0.0.1:52895_ x:collection1
s:shard2 c:tmp_collection r:core_node3) [n:127.0.0.1:52895_ c:tmp_collection
s:shard2 r:core_node3 x:collection1] o.a.s.c.RecoveryStrategy Publishing state
of core [collection1] as recovering, leader is
[https://127.0.0.1:37240/collection1/] and I am
[https://127.0.0.1:52895/collection1/]
[junit4] 2> 2669900 INFO
(recoveryExecutor-18192-thread-1-processing-n:127.0.0.1:52895_ x:collection1
s:shard2 c:tmp_collection r:core_node3) [n:127.0.0.1:52895_ c:tmp_collection
s:shard2 r:core_node3 x:collection1] o.a.s.c.RecoveryStrategy Sending prep
recovery command to [https://127.0.0.1:37240]; [WaitForState:
action=PREPRECOVERY&core=collection1&nodeName=127.0.0.1:52895_&coreNodeName=core_node3&state=recovering&checkLive=true&onlyIfLeader=true&onlyIfLeaderActive=true]
[junit4] 2> 2670011 INFO (qtp2004775346-71860) [n:127.0.0.1:37240_ ]
o.a.s.h.a.PrepRecoveryOp Going to wait for coreNodeName: core_node3, state:
recovering, checkLive: true, onlyIfLeader: true, onlyIfLeaderActive: true
[junit4] 2> 2670018 INFO (qtp2004775346-71860) [n:127.0.0.1:37240_ ]
o.a.s.h.a.PrepRecoveryOp Will wait a max of 183 seconds to see collection1
(shard2 of tmp_collection) have state: recovering
[junit4] 2> 2670019 INFO (qtp2004775346-71860) [n:127.0.0.1:37240_ ]
o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering):
collection=tmp_collection, shard=shard2, thisCore=collection1,
leaderDoesNotNeedRecovery=false, isLeader? true, live=true, checkLive=true,
currentState=recovering, localState=active, nodeName=127.0.0.1:52895_,
coreNodeName=core_node3, onlyIfActiveCheckResult=false, nodeProps:
core_node3:{"core":"collection1","base_url":"https://127.0.0.1:52895","node_name":"127.0.0.1:52895_","state":"recovering"}
[junit4] 2> 2670019 INFO (qtp2004775346-71860) [n:127.0.0.1:37240_ ]
o.a.s.h.a.PrepRecoveryOp Waited coreNodeName: core_node3, state: recovering,
checkLive: true, onlyIfLeader: true for: 0 seconds.
[junit4] 2> 2670019 INFO (qtp2004775346-71860) [n:127.0.0.1:37240_ ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={nodeName=127.0.0.1:52895_&onlyIfLeaderActive=true&core=collection1&coreNodeName=core_node3&action=PREPRECOVERY&checkLive=true&state=recovering&onlyIfLeader=true&wt=javabin&version=2}
status=0 QTime=7
[junit4] 2> 2670161 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-004/cores/collection1
[junit4] 2> 2670163 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 2670165 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@4ca032a6{/,null,AVAILABLE}
[junit4] 2> 2670166 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.e.j.s.ServerConnector Started ServerConnector@7b94828a{SSL,[ssl,
http/1.1]}{127.0.0.1:35581}
[junit4] 2> 2670166 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.e.j.s.Server Started @2678255ms
[junit4] 2> 2670166 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.s.e.JettySolrRunner Jetty properties: {shards=shard4,
hostContext=/, hostPort=35581,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-004/cores}
[junit4] 2> 2670167 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™
version 6.3.0
[junit4] 2> 2670167 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on
port null
[junit4] 2> 2670167 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2670167 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-10-04T13:55:10.123Z
[junit4] 2> 2670187 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 2670187 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-004/solr.xml
[junit4] 2> 2670199 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with
params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 2670202 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46256/solr
[junit4] 2> 2670251 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D])
[n:127.0.0.1:35581_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 2670277 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D])
[n:127.0.0.1:35581_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:35581_
[junit4] 2> 2670280 INFO
(zkCallback-18188-thread-1-processing-n:127.0.0.1:33122_) [n:127.0.0.1:33122_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2670281 INFO
(zkCallback-18194-thread-1-processing-n:127.0.0.1:52895_) [n:127.0.0.1:52895_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2670282 INFO
(zkCallback-18182-thread-3-processing-n:127.0.0.1:37240_) [n:127.0.0.1:37240_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2670282 INFO
(zkCallback-18201-thread-1-processing-n:127.0.0.1:35581_) [n:127.0.0.1:35581_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2670297 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D])
[n:127.0.0.1:35581_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-004/cores
[junit4] 2> 2670297 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D])
[n:127.0.0.1:35581_ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 2670299 INFO
(OverseerStateUpdate-96704220622290949-127.0.0.1:37240_-n_0000000000)
[n:127.0.0.1:37240_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 2671434 WARN
(coreLoadExecutor-7446-thread-1-processing-n:127.0.0.1:35581_)
[n:127.0.0.1:35581_ c:tmp_collection x:collection1] o.a.s.c.Config Beginning
with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 2671436 INFO
(coreLoadExecutor-7446-thread-1-processing-n:127.0.0.1:35581_)
[n:127.0.0.1:35581_ c:tmp_collection x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 6.3.0
[junit4] 2> 2671459 INFO
(coreLoadExecutor-7446-thread-1-processing-n:127.0.0.1:35581_)
[n:127.0.0.1:35581_ c:tmp_collection x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 2671547 WARN
(coreLoadExecutor-7446-thread-1-processing-n:127.0.0.1:35581_)
[n:127.0.0.1:35581_ c:tmp_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> 2671549 INFO
(coreLoadExecutor-7446-thread-1-processing-n:127.0.0.1:35581_)
[n:127.0.0.1:35581_ c:tmp_collection x:collection1] o.a.s.s.IndexSchema
Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 2671575 INFO
(coreLoadExecutor-7446-thread-1-processing-n:127.0.0.1:35581_)
[n:127.0.0.1:35581_ c:tmp_collection x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
tmp_collection
[junit4] 2> 2671575 INFO
(coreLoadExecutor-7446-thread-1-processing-n:127.0.0.1:35581_)
[n:127.0.0.1:35581_ c:tmp_collection s:shard1 r:core_node4 x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-004/cores/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrVersionReplicationTest_B02B01C054FBF51D-001/jetty-004/cores/collection1/data/]
[junit4] 2> 2671576 INFO
(coreLoadExecutor-7446-thread-1-processing-n:127.0.0.1:35581_)
[n:127.0.0.1:35581_ c:tmp_collection 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@1a9eaf15
[junit4] 2> 2671583 INFO
(coreLoadExecutor-7446-thread-1-processing-n:127.0.0.1:35581_)
[n:127.0.0.1:35581_ c:tmp_collection s:shard1 r:core_node4 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=46, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=36.099609375,
floorSegmentMB=1.9326171875, forceMergeDeletesPctAllowed=1.7175272038539502,
segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 2671640 INFO
(coreLoadExecutor-7446-thread-1-processing-n:127.0.0.1:35581_)
[n:127.0.0.1:35581_ c:tmp_collection s:shard1 r:core_node4 x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.CdcrUpdateLog
[junit4] 2> 2671640 INFO
(coreLoadExecutor-7446-thread-1-processing-n:127.0.0.1:35581_)
[n:127.0.0.1:35581_ c:tmp_collection 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> 2671641 INFO
(coreLoadExecutor-7446-thread-1-processing-n:127.0.0.1:35581_)
[n:127.0.0.1:35581_ c:tmp_collection s:shard1 r:core_node4 x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2671641 INFO
(coreLoadExecutor-7446-thread-1-processing-n:127.0.0.1:35581_)
[n:127.0.0.1:35581_ c:tmp_collection s:shard1 r:core_node4 x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2671646 INFO
(coreLoadExecutor-7446-thread-1-processing-n:127.0.0.1:35581_)
[n:127.0.0.1:35581_ c:tmp_collection s:shard1 r:core_node4 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=25, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 2671647 INFO
(coreLoadExecutor-7446-thread-1-processing-n:127.0.0.1:35581_)
[n:127.0.0.1:35581_ c:tmp_collection s:shard1 r:core_node4 x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@39e5f78a[collection1] main]
[junit4] 2> 2671649 INFO
(coreLoadExecutor-7446-thread-1-processing-n:127.0.0.1:35581_)
[n:127.0.0.1:35581_ c:tmp_collection s:shard1 r:core_node4 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 2671649 INFO
(coreLoadExecutor-7446-thread-1-processing-n:127.0.0.1:35581_)
[n:127.0.0.1:35581_ c:tmp_collection 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> 2671649 INFO
(coreLoadExecutor-7446-thread-1-processing-n:127.0.0.1:35581_)
[n:127.0.0.1:35581_ c:tmp_collection s:shard1 r:core_node4 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2671655 INFO
(searcherExecutor-7447-thread-1-processing-n:127.0.0.1:35581_ x:collection1
s:shard1 c:tmp_collection r:core_node4) [n:127.0.0.1:35581_ c:tmp_collection
s:shard1 r:core_node4 x:collection1] o.a.s.c.SolrCore [collection1] Registered
new searcher Searcher@39e5f78a[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2671655 INFO
(coreLoadExecutor-7446-thread-1-processing-n:127.0.0.1:35581_)
[n:127.0.0.1:35581_ c:tmp_collection 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 1547267538011815936
[junit4] 2> 2671660 INFO
(coreZkRegister-7441-thread-1-processing-n:127.0.0.1:35581_ x:collection1
s:shard1 c:tmp_collection r:core_node4) [n:127.0.0.1:35581_ c:tmp_collection
s:shard1 r:core_node4 x:collection1] o.a.s.c.ZkController Core needs to
recover:collection1
[junit4] 2> 2671660 INFO
(updateExecutor-18198-thread-1-processing-n:127.0.0.1:35581_ x:collection1
s:shard1 c:tmp_collection r:core_node4) [n:127.0.0.1:35581_ c:tmp_collection
s:shard1 r:core_node4 x:collection1] o.a.s.u.DefaultSolrCoreState Running
recovery
[junit4] 2> 2671660 INFO
(recoveryExecutor-18199-thread-1-processing-n:127.0.0.1:35581_ x:collection1
s:shard1 c:tmp_collection r:core_node4) [n:127.0.0.1:35581_ c:tmp_collection
s:shard1 r:core_node4 x:collection1] o.a.s.c.RecoveryStrategy Starting recovery
process. recoveringAfterStartup=true
[junit4] 2> 2671675 INFO
(recoveryExecutor-18199-thread-1-processing-n:127.0.0.1:35581_ x:collection1
s:shard1 c:tmp_collection r:core_node4) [n:127.0.0.1:35581_ c:tmp_collection
s:shard1 r:core_node4 x:collection1] o.a.s.c.RecoveryStrategy ######
startupVersions=[[]]
[junit4] 2> 2671675 INFO
(recoveryExecutor-18199-thread-1-processing-n:127.0.0.1:35581_ x:collection1
s:shard1 c:tmp_collection r:core_node4) [n:127.0.0.1:35581_ c:tmp_collection
s:shard1 r:core_node4 x:collection1] o.a.s.c.RecoveryStrategy Begin buffering
updates. core=[collection1]
[junit4] 2> 2671675 INFO
(recoveryExecutor-18199-thread-1-processing-n:127.0.0.1:35581_ x:collection1
s:shard1 c:tmp_collection r:core_node4) [n:127.0.0.1:35581_ c:tmp_collection
s:shard1 r:core_node4 x:collection1] o.a.s.u.UpdateLog Starting to buffer
updates. FSUpdateLog{state=ACTIVE, tlog=null}
[junit4] 2> 2671676 INFO
(recoveryExecutor-18199-thread-1-processing-n:127.0.0.1:35581_ x:collection1
s:shard1 c:tmp_collection r:core_node4) [n:127.0.0.1:35581_ c:tmp_collection
s:shard1 r:core_node4 x:collection1] o.a.s.c.RecoveryStrategy Publishing state
of core [collection1] as recovering, leader is
[https://127.0.0.1:33122/collection1/] and I am
[https://127.0.0.1:35581/collection1/]
[junit4] 2> 2671686 INFO
(recoveryExecutor-18199-thread-1-processing-n:127.0.0.1:35581_ x:collection1
s:shard1 c:tmp_collection r:core_node4) [n:127.0.0.1:35581_ c:tmp_collection
s:shard1 r:core_node4 x:collection1] o.a.s.c.RecoveryStrategy Sending prep
recovery command to [https://127.0.0.1:33122]; [WaitForState:
action=PREPRECOVERY&core=collection1&nodeName=127.0.0.1:35581_&coreNodeName=core_node4&state=recovering&checkLive=true&onlyIfLeader=true&onlyIfLeaderActive=true]
[junit4] 2> 2671794 INFO (qtp176143457-71895) [n:127.0.0.1:33122_ ]
o.a.s.h.a.PrepRecoveryOp Going to wait for coreNodeName: core_node4, state:
recovering, checkLive: true, onlyIfLeader: true, onlyIfLeaderActive: true
[junit4] 2> 2671806 INFO (qtp176143457-71895) [n:127.0.0.1:33122_ ]
o.a.s.h.a.PrepRecoveryOp Will wait a max of 183 seconds to see collection1
(shard1 of tmp_collection) have state: recovering
[junit4] 2> 2671807 INFO (qtp176143457-71895) [n:127.0.0.1:33122_ ]
o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering):
collection=tmp_collection, shard=shard1, thisCore=collection1,
leaderDoesNotNeedRecovery=false, isLeader? true, live=true, checkLive=true,
currentState=recovering, localState=active, nodeName=127.0.0.1:35581_,
coreNodeName=core_node4, onlyIfActiveCheckResult=false, nodeProps:
core_node4:{"core":"collection1","base_url":"https://127.0.0.1:35581","node_name":"127.0.0.1:35581_","state":"recovering"}
[junit4] 2> 2671807 INFO (qtp176143457-71895) [n:127.0.0.1:33122_ ]
o.a.s.h.a.PrepRecoveryOp Waited coreNodeName: core_node4, state: recovering,
checkLive: true, onlyIfLeader: true for: 0 seconds.
[junit4] 2> 2671807 INFO (qtp176143457-71895) [n:127.0.0.1:33122_ ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={nodeName=127.0.0.1:35581_&onlyIfLeaderActive=true&core=collection1&coreNodeName=core_node4&action=PREPRECOVERY&checkLive=true&state=recovering&onlyIfLeader=true&wt=javabin&version=2}
status=0 QTime=12
[junit4] 1> / (2)
[junit4] 1> DATA:
[junit4] 1>
[junit4] 1> /zookeeper (1)
[junit4] 1> DATA:
[junit4] 1>
[junit4] 1> /solr (9)
[junit4] 1> /solr/configs (1)
[junit4] 1> /solr/configs/conf1 (11)
[junit4] 1> /solr/configs/conf1/currency.xml (0)
[junit4] 1> DATA: ...supressed...
[junit4] 1> /solr/configs/conf1/enumsConfig.xml (0)
[junit4] 1> DATA: ...supressed...
[junit4] 1> /solr/configs/conf1/protwords.txt (0)
[junit4] 1> DATA: ...supressed...
[junit4] 1> /solr/configs/conf1/old_synonyms.txt (0)
[junit4] 1> DATA: ...supressed...
[junit4] 1> /solr/configs/conf1/solrconfig.xml (0)
[junit4] 1> DATA: ...supressed...
[junit4] 1> /solr/configs/conf1/synonyms.txt (0)
[junit4] 1> DATA: ...supressed...
[junit4] 1> /solr/configs/conf1/stopwords.txt (0)
[junit4] 1> DATA: ...supressed...
[junit4] 1> /solr/configs/conf1/schema.xml (0)
[junit4] 1> DATA: ...supressed...
[junit4] 1>
/solr/configs/conf1/solrconfig.snippet.randomindexconfig.xml (0)
[junit4] 1> DATA: ...supressed...
[junit4] 1> /solr/configs/conf1/mapping-ISOLatin1Accent.txt (0)
[junit4] 1> DATA: ...supressed...
[junit4] 1> /solr/configs/conf1/open-exchange-rates.json (0)
[junit4] 1> DATA:
[junit4] 1> {
[junit4] 1> "disclaimer": "This data is not real, it was
synthetically created to match currency.xml. It is modeled after the data
format available from openexchangerates.org. See
https://openexchangerates.org/documentation for details
[junit4] 1>
[junit4] 1>
[junit4] 1> IMPORTANT NOTE: In order for tests to work, this
data must be kept in sync with ./currency.xml",
[junit4] 1>
[junit4] 1>
[junit4] 1> "license":
"http://www.apache.org/licenses/LICENSE-2.0";,
[junit4] 1> "timestamp": 1332070464,
[junit4] 1> "base": "USD",
[junit4] 1> "rates": {
[junit4] 1> "USD": 1,
[junit4] 1> "JPY": 81.29,
[junit4] 1> "EUR": 2.5,
[junit4] 1> "GBP": 0.5,
[junit4] 1> "MXN": 2.0
[junit4] 1> }
[junit4] 1> }
[junit4] 1>
[junit4] 1> /solr/overseer (6)
[junit4] 1> DATA:
[junit4] 1>
[junit4] 1> /solr/overseer/collection-queue-work (0)
[junit4] 1> /solr/overseer/queue-work (0)
[junit4] 1> /solr/overseer/collection-map-failure (0)
[junit4] 1> /solr/overseer/collection-map-completed (0)
[junit4] 1> /solr/overseer/queue (0)
[junit4] 1> /solr/overseer/collection-map-running (0)
[junit4] 1> /solr/aliases.json (0)
[junit4] 1> /solr/collections (3)
[junit4] 1> /solr/collections/collection1 (1)
[junit4] 1> DATA:
[junit4] 1> {"configName":"conf1"}
[junit4] 1> /solr/collections/collection1/shards (0)
[junit4] 1> /solr/collections/tmp_collection (3)
[junit4] 1> DATA:
[junit4] 1> {"configName":"conf1"}
[junit4] 1> /solr/collections/tmp_collection/leaders (2)
[junit4] 1> /solr/collections/tmp_collection/leaders/shard2 (1)
[junit4] 1> /solr/collections/tmp_collection/leaders/shard2/leader
(0)
[junit4] 1> DATA:
[junit4] 1> {
[junit4] 1> "core":"collection1",
[junit4] 1> "core_node_name":"core_node1",
[junit4] 1> "base_url":"https://127.0.0.1:37240";,
[junit4] 1> "node_name":"127.0.0.1:37240_"}
[junit4] 1> /solr/collections/tmp_collection/leaders/shard1 (1)
[junit4] 1> /solr/collections/tmp_collection/leaders/shard1/leader
(0)
[junit4] 1> DATA:
[junit4] 1> {
[junit4] 1> "core":"collection1",
[junit4] 1> "core_node_name":"core_node2",
[junit4] 1> "base_url":"https://127.0.0.1:33122";,
[junit4] 1> "node_name":"127.0.0.1:33122_"}
[junit4] 1> /solr/collections/tmp_collection/cdcr (1)
[junit4] 1> /solr/collections/tmp_collection/cdcr/state (2)
[junit4] 1> /solr/collections/tmp_collection/cdcr/state/process (0)
[junit4] 1> DATA:
[junit4] 1> stopped
[junit4] 1> /solr/collections/tmp_collection/cdcr/state/buffer (0)
[junit4] 1> DATA:
[junit4] 1> enabled
[junit4] 1> /solr/collections/tmp_collection/leader_elect (2)
[junit4] 1> /solr/collections/tmp_collection/leader_elect/shard2 (1)
[junit4] 1>
/solr/collections/tmp_collection/leader_elect/shard2/election (2)
[junit4] 1>
/solr/collections/tmp_collection/leader_elect/shard2/election/96704220622290949-core_node1-n_0000000000
(0)
[junit4] 1>
/solr/collections/tmp_collection/leader_elect/shard2/election/96704220622290955-core_node3-n_0000000001
(0)
[junit4] 1> /solr/collections/tmp_collection/leader_elect/shard1 (1)
[junit4] 1>
/solr/collections/tmp_collection/leader_elect/shard1/election (2)
[junit4] 1>
/solr/collections/tmp_collection/leader_elect/shard1/election/96704220622290952-core_node2-n_0000000000
(0)
[junit4] 1>
/solr/collections/tmp_collection/leader_elect/shard1/election/96704220622290958-core_node4-n_0000000001
(0)
[junit4] 1> /solr/collections/control_collection (1)
[junit4] 1> DATA:
[junit4] 1> {"configName":"conf1"}
[junit4] 1> /solr/collections/control_collection/shards (0)
[junit4] 1> /solr/live_nodes (4)
[junit4] 1> /solr/live_nodes/127.0.0.1:37240_ (0)
[junit4] 1> /solr/live_nodes/127.0.0.1:52895_ (0)
[junit4] 1> /solr/live_nodes/127.0.0.1:33122_ (0)
[junit4] 1> /solr/live_nodes/127.0.0.1:35581_ (0)
[junit4] 1> /solr/overseer_elect (2)
[junit4] 1> /solr/overseer_elect/leader (0)
[junit4] 1> DATA:
[junit4] 1> {"id":"96704220622290949-127.0.0.1:37240_-n_0000000000"}
[junit4] 1> /solr/overseer_elect/election (4)
[junit4] 1>
/solr/overseer_elect/election/96704220622290958-127.0.0.1:35581_-n_0000000003
(0)
[junit4] 1>
/solr/overseer_elect/election/96704220622290952-127.0.0.1:33122_-n_0000000001
(0)
[junit4] 1>
/solr/overseer_elect/election/96704220622290949-127.0.0.1:37240_-n_0000000000
(0)
[junit4] 1>
/solr/overseer_elect/election/96704220622290955-127.0.0.1:52895_-n_0000000002
(0)
[junit4] 1> /solr/security.json (0)
[junit4] 1> DATA:
[junit4] 1> {}
[junit4] 1> /solr/clusterstate.json (0)
[junit4] 1> DATA:
[junit4] 1> {"tmp_collection":{
[junit4] 1> "replicationFactor":"1",
[junit4] 1> "router":{"name":"compositeId"},
[junit4] 1> "maxShardsPerNode":"1",
[junit4] 1> "autoAddReplicas":"false",
[junit4] 1> "autoCreated":"true",
[junit4] 1> "shards":{
[junit4] 1> "shard1":{
[junit4] 1> "range":"80000000-ffffffff",
[junit4] 1> "state":"active",
[junit4] 1> "replicas":{
[junit4] 1> "core_node2":{
[junit4] 1> "core":"collection1",
[junit4] 1> "base_url":"https://127.0.0.1:33122";,
[junit4] 1> "node_name":"127.0.0.1:33122_",
[junit4] 1> "state":"active",
[junit4] 1> "leader":"true"},
[junit4] 1> "core_node4":{
[junit4] 1> "core":"collection1",
[junit4] 1> "base_url":"https://127.0.0.1:35581";,
[junit4] 1> "node_name":"127.0.0.1:35581_",
[junit4] 1> "state":"recovering"}}},
[junit4] 1> "shard2":{
[junit4] 1> "range":"0-7fffffff",
[junit4] 1> "state":"active",
[junit4] 1> "replicas":{
[junit4] 1> "core_node1":{
[junit4] 1> "core":"collection1",
[junit4] 1> "base_url":"https://127.0.0.1:37240";,
[junit4] 1> "node_name":"127.0.0.1:37240_",
[junit4] 1> "state":"active",
[junit4] 1> "leader":"true"},
[junit4] 1> "core_node3":{
[junit4] 1> "core":"collection1",
[junit4] 1> "base_url":"https://127.0.0.1:52895";,
[junit4] 1> "node_name":"127.0.0.1:52895_",
[junit4] 1> "state":"recovering"}}}}}}
[junit4] 1> /solr/clusterprops.json (0)
[junit4] 1> DATA:
[junit4] 1> {"urlScheme":"https"}
[junit4] 1>
[junit4] 1> / (2)
[junit4] 1> DATA:
[junit4] 1>
[junit4] 1> /zookeeper (1)
[junit4] 1> DATA:
[junit4] 1>
[junit4] 1> /solr (9)
[junit4] 1> /solr/configs (1)
[junit4] 1> /solr/configs/conf1 (11)
[junit4] 1> /solr/configs/conf1/currency.xml (0)
[junit4] 1> DATA: ...supressed...
[junit4] 1> /solr/configs/conf1/enumsConfig.xml (0)
[junit4] 1> DATA: ...supressed...
[junit4] 1> /solr/configs/conf1/protwords.txt (0)
[junit4] 1> DATA: ...supressed...
[junit4] 1> /solr/configs/conf1/old_synonyms.txt (0)
[junit4] 1> DATA: ...supressed...
[junit4] 1> /solr/configs/conf1/solrconfig.xml (0)
[junit4] 1> DATA: ...supressed...
[junit4] 1> /solr/configs/conf1/synonyms.txt (0)
[junit4] 1> DATA: ...supressed...
[junit4] 1> /solr/configs/conf1/stopwords.txt (0)
[junit4] 1> DATA: ...supressed...
[junit4] 1> /solr/configs/conf1/schema.xml (0)
[junit4] 1> DATA: ...supressed...
[junit4] 1>
/solr/configs/conf1/solrconfig.snippet.randomindexconfig.xml (0)
[junit4] 1> DATA: ...supressed...
[junit4] 1> /solr/configs/conf1/mapping-ISOLatin1Accent.txt (0)
[junit4] 1> DATA: ...supressed...
[junit4] 1> /solr/configs/conf1/open-exchange-rates.json (0)
[junit4] 1> DATA:
[junit4] 1> {
[junit4] 1> "disclaimer": "This data is not real, it was
synthetically created to match currency.xml. It is modeled after the data
format available from openexchangerates.org. See
https://openexchangerates.org/documentation for details
[junit4] 1>
[junit4] 1>
[junit4] 1> IMPORTANT NOTE: In order for tests to work, this
data must be kept in sync with ./currency.xml",
[junit4] 1>
[junit4] 1>
[junit4] 1> "license":
"http://www.apache.org/licenses/LICENSE-2.0";,
[junit4] 1> "timestamp": 1332070464,
[junit4] 1> "base": "USD",
[junit4] 1> "rates": {
[junit4] 1> "USD": 1,
[junit4] 1> "JPY": 81.29,
[junit4] 1> "EUR": 2.5,
[junit4] 1> "GBP": 0.5,
[junit4] 1> "MXN": 2.0
[junit4] 1> }
[junit4] 1> }
[junit4] 1>
[junit4] 1> /solr/overseer (6)
[junit4] 1> DATA:
[junit4] 1>
[junit4] 1> /solr/overseer/collection-queue-work (0)
[junit4] 1> /solr/overseer/queue-work (0)
[junit4] 1> /solr/overseer/collection-map-failure (0)
[junit4] 1> /solr/overseer/collection-map-completed (0)
[junit4] 1> /solr/overseer/queue (0)
[junit4] 1> /solr/overseer/collection-map-running (0)
[junit4] 1> /solr/aliases.json (0)
[junit4] 1> /solr/collections (3)
[junit4] 1> /solr/collections/collection1 (1)
[junit4] 1> DATA:
[junit4] 1> {"configName":"conf1"}
[junit4] 1> /solr/collections/collection1/shards (0)
[junit4] 1> /solr/collections/tmp_collection (3)
[junit4] 1> DATA:
[junit4] 1> {"configName":"conf1"}
[junit4] 1> /solr/collections/tmp_collection/leaders (2)
[junit4] 1> /solr/collections/tmp_collection/leaders/shard2 (1)
[junit4] 1> /solr/collections/tmp_collection/leaders/shard2/leader
(0)
[junit4] 1> DATA:
[junit4] 1> {
[junit4] 1> "core":"collection1",
[junit4] 1> "core_node_name":"core_node1",
[junit4] 1> "base_url":"https://127.0.0.1:37240";,
[junit4] 1> "node_name":"127.0.0.1:37240_"}
[junit4] 1> /solr/collections/tmp_collection/leaders/shard1 (1)
[junit4] 1> /solr/collections/tmp_collection/leaders/shard1/leader
(0)
[junit4] 1> DATA:
[junit4] 1> {
[junit4] 1> "core":"collection1",
[junit4] 1> "core_node_name":"core_node2",
[junit4] 1> "base_url":"https://127.0.0.1:33122";,
[junit4] 1> "node_name":"127.0.0.1:33122_"}
[junit4] 1> /solr/collections/tmp_collection/cdcr (1)
[junit4] 1> /solr/collections/tmp_collection/cdcr/state (2)
[junit4] 1> /solr/collections/tmp_collection/cdcr/state/process (0)
[junit4] 1> DATA:
[junit4] 1> stopped
[junit4] 1> /solr/collections/tmp_collection/cdcr/state/buffer (0)
[junit4] 1> DATA:
[junit4] 1> enabled
[junit4] 1> /solr/collections/tmp_collection/leader_elect (2)
[junit4] 1> /solr/collections/tmp_collection/leader_elect/shard2 (1)
[junit4] 1>
/solr/collections/tmp_collection/leader_elect/shard2/election (2)
[junit4] 1>
/solr/collections/tmp_collection/leader_elect/shard2/election/96704220622290949-core_node1-n_0000000000
(0)
[junit4] 1>
/solr/collections/tmp_collection/leader_elect/shard2/election/96704220622290955-core_node3-n_0000000001
(0)
[junit4] 1> /solr/collections/tmp_collection/leader_elect/shard1 (1)
[junit4] 1>
/solr/collections/tmp_collection/leader_elect/shard1/election (2)
[junit4] 1>
/solr/collections/tmp_collection/leader_elect/shard1/election/96704220622290952-core_node2-n_0000000000
(0)
[junit4] 1>
/solr/collections/tmp_collection/leader_elect/shard1/election/96704220622290958-core_node4-n_0000000001
(0)
[junit4] 1> /solr/collections/control_collection (1)
[junit4] 1> DATA:
[junit4] 1> {"configName":"conf1"}
[junit4] 1> /solr/collections/control_collection/shards (0)
[junit4] 1> /solr/live_nodes (4)
[junit4] 1> /solr/live_nodes/127.0.0.1:37240_ (0)
[junit4] 1> /solr/live_nodes/127.0.0.1:52895_ (0)
[junit4] 1> /solr/live_nodes/127.0.0.1:33122_ (0)
[junit4] 1> /solr/live_nodes/127.0.0.1:35581_ (0)
[junit4] 1> /solr/overseer_elect (2)
[junit4] 1> /solr/overseer_elect/leader (0)
[junit4] 1> DATA:
[junit4] 1> {"id":"96704220622290949-127.0.0.1:37240_-n_0000000000"}
[junit4] 1> /solr/overseer_elect/election (4)
[junit4] 1>
/solr/overseer_elect/election/96704220622290958-127.0.0.1:35581_-n_0000000003
(0)
[junit4] 1>
/solr/overseer_elect/election/96704220622290952-127.0.0.1:33122_-n_0000000001
(0)
[junit4] 1>
/solr/overseer_elect/election/96704220622290949-127.0.0.1:37240_-n_0000000000
(0)
[junit4] 1>
/solr/overseer_elect/election/96704220622290955-127.0.0.1:52895_-n_0000000002
(0)
[junit4] 1> /solr/security.json (0)
[junit4] 1> DATA:
[junit4] 1> {}
[junit4] 1> /solr/clusterstate.json (0)
[junit4] 1> DATA:
[junit4] 1> {"tmp_collection":{
[junit4] 1> "replicationFactor":"1",
[junit4] 1> "router":{"name":"compositeId"},
[junit4] 1> "maxShardsPerNode":"1",
[junit4] 1> "autoAddReplicas":"false",
[junit4] 1> "autoCreated":"true",
[junit4] 1> "shards":{
[junit4] 1> "shard1":{
[junit4] 1> "range":"80000000-ffffffff",
[junit4] 1> "state":"active",
[junit4] 1> "replicas":{
[junit4] 1> "core_node2":{
[junit4] 1> "core":"collection1",
[junit4] 1> "base_url":"https://127.0.0.1:33122";,
[junit4] 1> "node_name":"127.0.0.1:33122_",
[junit4] 1> "state":"active",
[junit4] 1> "leader":"true"},
[junit4] 1> "core_node4":{
[junit4] 1> "core":"collection1",
[junit4] 1> "base_url":"https://127.0.0.1:35581";,
[junit4] 1> "node_name":"127.0.0.1:35581_",
[junit4] 1> "state":"recovering"}}},
[junit4] 1> "shard2":{
[junit4] 1> "range":"0-7fffffff",
[junit4] 1> "state":"active",
[junit4] 1> "replicas":{
[junit4] 1> "core_node1":{
[junit4] 1> "core":"collection1",
[junit4] 1> "base_url":"https://127.0.0.1:37240";,
[junit4] 1> "node_name":"127.0.0.1:37240_",
[junit4] 1> "state":"active",
[junit4] 1> "leader":"true"},
[junit4] 1> "core_node3":{
[junit4] 1> "core":"collection1",
[junit4] 1> "base_url":"https://127.0.0.1:52895";,
[junit4] 1> "node_name":"127.0.0.1:52895_",
[junit4] 1> "state":"recovering"}}}}}}
[junit4] 1> /solr/clusterprops.json (0)
[junit4] 1> DATA:
[junit4] 1> {"urlScheme":"https"}
[junit4] 1>
[junit4] 2> 2672017 INFO
(TEST-CdcrVersionReplicationTest.testCdcrDocVersions-seed#[B02B01C054FBF51D]) [
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 2672033 INFO (qtp2004775346-71858) [n:127.0.0.1:37240_ ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params
name=tmp_collection&action=DELETE&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 2672035 INFO
(OverseerThreadFactory-7409-thread-1-processing-n:127.0.0.1:37240_)
[n:127.0.0.1:37240_ ] o.a.s.c.OverseerCollectionMessageHandler Executing
Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true
[junit4] 2> 2672058 INFO (qtp2004775346-71861) [n:127.0.0.1:37240_ ]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@17cf7564
[junit4] 2> 2672058 INFO (qtp2004775346-71861) [n:127.0.0.1:37240_ ]
o.a.s.h.CdcrRequestHandler Solr core is being closed - shutting down CDCR
handler @ tmp_collection:shard2
[junit4] 2> 2672112 INFO (qtp176143457-71894) [n:127.0.0.1:33122_ ]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@5c850358
[junit4] 2> 2672112 INFO (qtp176143457-71894) [n:127.0.0.1:33122_ ]
o.a.s.h.CdcrRequestHandler Solr core is being closed - shutting down CDCR
handler @ tmp_collection:shard1
[junit4] 2> 2672165 INFO (qtp2004775346-71861) [n:127.0.0.1:37240_ ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={deleteInstanceDir=true&core=collection1&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
status=0 QTime=107
[junit4] 2> 2672167 INFO
(zkCallback-18194-thread-1-processing-n:127.0.0.1:52895_) [n:127.0.0.1:52895_
c:tmp_collection s:shard2 r:core_node3 x:collection1]
o.a.s.c.ShardLeaderElectionContext There may be a better leader candidate than
us - going back into recovery
[junit4] 2> 2672168 INFO
(zkCallback-18194-thread-1-processing-n:127.0.0.1:52895_) [n:127.0.0.1:52895_
c:tmp_collection s:shard2 r:core_node3 x:collection1]
o.a.s.c.ShardLeaderElectionContextBase No version found for ephemeral leader
parent node, won't remove previous leader registration.
[junit4] 2> 2672182 INFO
(zkCallback-18194-thread-2-processing-n:127.0.0.1:52895_) [n:127.0.0.1:52895_
] o.a.s.h.CdcrLeaderStateManager Received new leader state @
tmp_collection:shard2
[junit4] 2> 2672203 INFO
(zkCallback-18194-thread-1-processing-n:127.0.0.1:52895_) [n:127.0.0.1:52895_
c:tmp_collection s:shard2 r:core_node3 x:collection1] o.a.s.c.ActionThrottle
The last leader attempt started 44ms ago.
[junit4] 2> 2672203 INFO
(zkCallback-18194-thread-1-processing-n:127.0.0.1:52895_) [n:127.0.0.1:52895_
c:tmp_collection s:shard2 r:core_node3 x:collection1] o.a.s.c.ActionThrottle
Throttling leader attempts - waiting for 4955ms
[junit4] 2> 2672209 INFO (qtp176143457-71894) [n:127.0.0.1:33122_ ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={deleteInstanceDir=true&core=collection1&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
status=0 QTime=97
[junit4] 2> 2672210 INFO
(zkCallback-18201-thread-1-processing-n:127.0.0.1:35581_) [n:127.0.0.1:35581_
c:tmp_collection s:shard1 r:core_node4 x:collection1]
o.a.s.c.ShardLeaderElectionContext There may be a better leader candidate than
us - going back into recovery
[junit4] 2> 2672211 INFO
(zkCallback-18201-thread-1-processing-n:127.0.0.1:35581_) [n:127.0.0.1:35581_
c:tmp_collection s:shard1 r:core_node4 x:collection1]
o.a.s.c.ShardLeaderElectionContextBase No version found for ephemeral leader
parent node, won't remove previous leader registration.
[junit4] 2> 2672215 INFO (zkCallback-18201-thread-2-processing-n:127.0.0.1
[...truncated too long message...]
DistribZkTestBase.destroyServers(AbstractFullDistribZkTestBase.java:1540)
[junit4] 2> at
org.apache.solr.BaseDistributedSearchTestCase.distribTearDown(BaseDistributedSearchTestCase.java:314)
[junit4] 2> at
org.apache.solr.cloud.AbstractDistribZkTestBase.distribTearDown(AbstractDistribZkTestBase.java:283)
[junit4] 2> at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.distribTearDown(AbstractFullDistribZkTestBase.java:1514)
[junit4] 2> at
org.apache.solr.cloud.BasicDistributedZkTest.distribTearDown(BasicDistributedZkTest.java:1142)
[junit4] 2> at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:969)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
[junit4] 2> at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 11) Thread[id=2371,
name=org.eclipse.jetty.server.session.HashSessionManager@1b8c3cd7Timer,
state=TIMED_WAITING, group=TGRP-BasicDistributedZkTest]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] 2> at
java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
[junit4] 2> at
java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 12) Thread[id=2380,
name=TEST-BasicDistributedZkTest.test-seed#[B02B01C054FBF51D]-SendThread(127.0.0.1:39243),
state=TIMED_WAITING, group=TGRP-BasicDistributedZkTest]
[junit4] 2> at java.lang.Thread.sleep(Native Method)
[junit4] 2> at
org.apache.zookeeper.client.StaticHostProvider.next(StaticHostProvider.java:101)
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:940)
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1003)
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62):
{regex_dup_A_s=PostingsFormat(name=Memory doPackFST= false),
other_tl1=PostingsFormat(name=Direct),
regex_dup_B_s=PostingsFormat(name=Direct),
range_facet_l_dv=PostingsFormat(name=LuceneFixedGap),
SubjectTerms_mfacet=PostingsFormat(name=Direct),
n_l1=PostingsFormat(name=Direct), multiDefault=BlockTreeOrds(blocksize=128),
intDefault=PostingsFormat(name=Direct), genre_s=PostingsFormat(name=Memory
doPackFST= false), n_td1=BlockTreeOrds(blocksize=128),
n_d1=PostingsFormat(name=Direct), range_facet_l=PostingsFormat(name=Direct),
n_f1=BlockTreeOrds(blocksize=128), series_t=BlockTreeOrds(blocksize=128),
n_tl1=BlockTreeOrds(blocksize=128), oddField_s=PostingsFormat(name=Memory
doPackFST= false), n_tf1=PostingsFormat(name=Direct),
price=PostingsFormat(name=Memory doPackFST= false),
a_t=PostingsFormat(name=Direct), cat=PostingsFormat(name=Direct),
inStock=PostingsFormat(name=Memory doPackFST= false),
sequence_i=PostingsFormat(name=Memory doPackFST= false),
id=PostingsFormat(name=LuceneFixedGap), text=PostingsFormat(name=Memory
doPackFST= false), timestamp=PostingsFormat(name=Direct),
foo_i=BlockTreeOrds(blocksize=128), val_i=PostingsFormat(name=LuceneFixedGap),
n_dt1=BlockTreeOrds(blocksize=128), author_t=BlockTreeOrds(blocksize=128),
a_i1=PostingsFormat(name=Direct), n_ti1=PostingsFormat(name=LuceneFixedGap),
rnd_b=PostingsFormat(name=LuceneFixedGap),
_version_=PostingsFormat(name=Direct), foo_b=PostingsFormat(name=Memory
doPackFST= false), n_tdt1=PostingsFormat(name=Direct),
name=PostingsFormat(name=LuceneFixedGap),
foo_d=PostingsFormat(name=LuceneFixedGap),
range_facet_i_dv=PostingsFormat(name=Direct), foo_f=PostingsFormat(name=Memory
doPackFST= false)},
docValues:{range_facet_l_dv=DocValuesFormat(name=Asserting),
range_facet_i_dv=DocValuesFormat(name=Memory),
timestamp=DocValuesFormat(name=Memory)}, maxPointsInLeafNode=757,
maxMBSortInHeap=6.0290868631778505, sim=ClassicSimilarity, locale=ar-OM,
timezone=Japan
[junit4] 2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation
1.8.0_102 (64-bit)/cpus=4,threads=21,free=252041296,total=481296384
[junit4] 2> NOTE: All tests run in this JVM: [TestFastLRUCache,
TestDynamicLoading, BufferStoreTest, ResourceLoaderTest,
TestSolrCloudWithKerberosAlt, TestHdfsUpdateLog,
TestHighFrequencyDictionaryFactory, TestFieldCacheSanityChecker,
CursorPagingTest, TestBinaryResponseWriter, SaslZkACLProviderTest,
SolrCoreTest, QueryElevationComponentTest, TestHdfsCloudBackupRestore,
BasicDistributedZkTest]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=BasicDistributedZkTest -Dtests.seed=B02B01C054FBF51D
-Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=ar-OM
-Dtests.timezone=Japan -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J0 | BasicDistributedZkTest (suite) <<<
[junit4] > Throwable #1: java.lang.Exception: Suite timeout exceeded (>=
7200000 msec).
[junit4] > at
__randomizedtesting.SeedInfo.seed([B02B01C054FBF51D]:0)
[junit4] Completed [546/637 (2!)] on J0 in 7225.43s, 1 test, 2 errors <<<
FAILURES!
[...truncated 11320 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:763: The
following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:715: Some
of the tests produced a heap dump, but did not fail. Maybe a suppressed
OutOfMemoryError? Dumps created:
* java_pid8259.hprof
Total time: 188 minutes 51 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
