Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-MacOSX/1979/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseParallelGC
1 tests failed.
FAILED: org.apache.solr.cloud.DeleteReplicaTest.deleteLiveReplicaTest
Error Message:
Should have had a good message here
Stack Trace:
java.lang.AssertionError: Should have had a good message here
at
__randomizedtesting.SeedInfo.seed([BAEC14A249145254:178CA0A9542BFA21]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.cloud.DeleteReplicaTest.deleteLiveReplicaTest(DeleteReplicaTest.java:125)
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:483)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:940)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:915)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
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:54)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 9068 lines...]
[junit4] Suite: org.apache.solr.cloud.DeleteReplicaTest
[junit4] 2> log4j:WARN No such property [conversionPattern] in
org.apache.solr.util.SolrLogLayout.
[junit4] 2> Creating dataDir:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/init-core-data-001
[junit4] 2> 2776 T11 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(false) and clientAuth (false)
[junit4] 2> 2898 T11 oas.BaseDistributedSearchTestCase.initHostContext
Setting hostContext system property: /eq_t/
[junit4] 2> 2996 T11 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 3007 T12 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting
server
[junit4] 2> 3307 T11 oasc.ZkTestServer.run start zk server on port:49203
[junit4] 2> 3491 T11
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3690 T11 oascc.ConnectionManager.waitForConnected Waiting for
client to connect to ZooKeeper
[junit4] 2> 4003 T19 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@3744e664
name:ZooKeeperConnection Watcher:127.0.0.1:49203 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 4005 T11 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 4035 T11 oascc.SolrZkClient.createZkACLProvider Using default
ZkACLProvider
[junit4] 2> 4049 T11 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 4186 T11
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 4193 T11 oascc.ConnectionManager.waitForConnected Waiting for
client to connect to ZooKeeper
[junit4] 2> 4196 T22 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@22e4d12d
name:ZooKeeperConnection Watcher:127.0.0.1:49203/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 4197 T11 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 4198 T11 oascc.SolrZkClient.createZkACLProvider Using default
ZkACLProvider
[junit4] 2> 4248 T11 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 4264 T11 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 4278 T11 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 4311 T11 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 4323 T11 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 4374 T11 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 4389 T11 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 4391 T11 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 4402 T11 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 4404 T11 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 4415 T11 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 4417 T11 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 4428 T11 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 4430 T11 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 4442 T11 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 4445 T11 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 4458 T11 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 4460 T11 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 4475 T11 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 4477 T11 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 4488 T11 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 4492 T11 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 4504 T11 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 4505 T11 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 4515 T11 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 4518 T11 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> 7357 T11 oas.SolrTestCaseJ4.writeCoreProperties Writing
core.properties file to
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/control-001/cores/collection1
[junit4] 2> 7663 T11 oejul.Log.initialized Logging initialized @11784ms
[junit4] 2> 8404 T11 oejs.Server.doStart jetty-9.2.6.v20141205
[junit4] 2> 8681 T11 oejsh.ContextHandler.doStart Started
o.e.j.s.ServletContextHandler@66bf90bd{/eq_t,null,AVAILABLE}
[junit4] 2> 8712 T11 oejs.AbstractConnector.doStart Started
ServerConnector@c1f21b0{HTTP/1.1}{127.0.0.1:49206}
[junit4] 2> 8719 T11 oejs.Server.doStart Started @12862ms
[junit4] 2> 8823 T11 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@4554617c
[junit4] 2> 8877 T11 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 8878 T11 oasc.SolrResourceLoader.locateSolrHome using system
property solr.solr.home:
../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/control-001
[junit4] 2> 8879 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader
for directory:
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/control-001/'
[junit4] 2> 9579 T11 oasc.ConfigSolr.fromFile Loading container
configuration from
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/control-001/solr.xml
[junit4] 2> 10015 T11 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/control-001/cores
[junit4] 2> 10048 T11 oasc.CoreContainer.<init> New CoreContainer
1232516451
[junit4] 2> 10050 T11 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/control-001/]
[junit4] 2> 10217 T11 oashc.HttpShardHandlerFactory.getParameter Setting
socketTimeout to: 90000
[junit4] 2> 10219 T11 oashc.HttpShardHandlerFactory.getParameter Setting
urlScheme to:
[junit4] 2> 10235 T11 oashc.HttpShardHandlerFactory.getParameter Setting
connTimeout to: 15000
[junit4] 2> 10236 T11 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnectionsPerHost to: 20
[junit4] 2> 10237 T11 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnections to: 10000
[junit4] 2> 10238 T11 oashc.HttpShardHandlerFactory.getParameter Setting
corePoolSize to: 0
[junit4] 2> 10239 T11 oashc.HttpShardHandlerFactory.getParameter Setting
maximumPoolSize to: 2147483647
[junit4] 2> 10240 T11 oashc.HttpShardHandlerFactory.getParameter Setting
maxThreadIdleTime to: 5
[junit4] 2> 10240 T11 oashc.HttpShardHandlerFactory.getParameter Setting
sizeOfQueue to: -1
[junit4] 2> 10241 T11 oashc.HttpShardHandlerFactory.getParameter Setting
fairnessPolicy to: false
[junit4] 2> 10242 T11 oashc.HttpShardHandlerFactory.getParameter Setting
useRetries to: false
[junit4] 2> 10766 T11 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 10783 T11 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 10787 T11 oasl.LogWatcher.newRegisteredLogWatcher Registering
Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 10794 T11 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 10794 T11 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:49203/solr
[junit4] 2> 10841 T11 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 10842 T11
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 10845 T11 oascc.ConnectionManager.waitForConnected Waiting for
client to connect to ZooKeeper
[junit4] 2> 10863 T37 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@f800e7c name:ZooKeeperConnection
Watcher:127.0.0.1:49203 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 10865 T11 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 10866 T11 oascc.SolrZkClient.createZkACLProvider Using default
ZkACLProvider
[junit4] 2> 10892 T11 oascc.ConnectionManager.waitForConnected Waiting for
client to connect to ZooKeeper
[junit4] 2> 10896 T40 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@a619c25 name:ZooKeeperConnection
Watcher:127.0.0.1:49203/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 10897 T11 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 10923 T11 oascc.SolrZkClient.makePath makePath: /overseer/queue
[junit4] 2> 10944 T11 oascc.SolrZkClient.makePath makePath:
/overseer/collection-queue-work
[junit4] 2> 10964 T11 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-running
[junit4] 2> 10977 T11 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-completed
[junit4] 2> 10988 T11 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-failure
[junit4] 2> 11018 T11 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 11025 T11 oasc.ZkController.createEphemeralLiveNode Register
node as live in ZooKeeper:/live_nodes/127.0.0.1:49206_eq_t
[junit4] 2> 11034 T11 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:49206_eq_t
[junit4] 2> 11049 T11 oascc.SolrZkClient.makePath makePath: /overseer_elect
[junit4] 2> 11057 T11 oascc.SolrZkClient.makePath makePath:
/overseer_elect/election
[junit4] 2> 11065 T11 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 11095 T11 oasc.OverseerElectionContext.runLeaderProcess I am
going to be the leader 127.0.0.1:49206_eq_t
[junit4] 2> 11095 T11 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 11102 T11 oasc.Overseer.start Overseer
(id=93274686620172291-127.0.0.1:49206_eq_t-n_0000000000) starting
[junit4] 2> 11125 T11 oascc.SolrZkClient.makePath makePath:
/overseer/queue-work
[junit4] 2> 11263 T11 oasc.OverseerAutoReplicaFailoverThread.<init>
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=10000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 11682 T42 oasc.OverseerCollectionProcessor.run Process current
queue of collection creations
[junit4] 2> 11686 T11 oascc.SolrZkClient.makePath makePath:
/clusterstate.json
[junit4] 2> 11704 T11 oascc.SolrZkClient.makePath makePath: /aliases.json
[junit4] 2> 11712 T11
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 11792 T41 oasc.Overseer$ClusterStateUpdater.run Starting to
work on the main queue
[junit4] 2> 12052 T11 oasc.CorePropertiesLocator.discover Looking for core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/control-001/cores
[junit4] 2> 12216 T11 oasc.CorePropertiesLocator.discoverUnder Found core
collection1 in
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/control-001/cores/collection1/
[junit4] 2> 12216 T11 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 12225 T44 oasc.ZkController.publish publishing
core=collection1 state=down collection=control_collection
[junit4] 2> 12227 T44 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 12250 T40 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 12250 T44 oasc.ZkController.waitForCoreNodeName look for our
core node name
[junit4] 2> 12270 T41 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 0, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49206/eq_t";,
[junit4] 2> "node_name":"127.0.0.1:49206_eq_t",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 12311 T41 oasco.ReplicaMutator.updateState Update state
numShards=1 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49206/eq_t";,
[junit4] 2> "node_name":"127.0.0.1:49206_eq_t",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 12315 T41 oasco.ClusterStateMutator.createCollection building
a new cName: control_collection
[junit4] 2> 12348 T41 oasco.ReplicaMutator.updateState Assigning new node
to shard shard=shard1
[junit4] 2> 12366 T40 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 13254 T44 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for collection1
[junit4] 2> 13255 T44 oasc.ZkController.createCollectionZkNode Check for
collection zkNode:control_collection
[junit4] 2> 13256 T44 oasc.ZkController.createCollectionZkNode Collection
zkNode exists
[junit4] 2> 13257 T44 oascc.ZkStateReader.readConfigName Load collection
config from:/collections/control_collection
[junit4] 2> 13262 T44 oascc.ZkStateReader.readConfigName
path=/collections/control_collection configName=conf1 specified config exists
in ZooKeeper
[junit4] 2> 13267 T44 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/control-001/cores/collection1/'
[junit4] 2> 13339 T44 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 13431 T44 oasc.Config.<init> loaded config solrconfig.xml with
version 0
[junit4] 2> 13570 T44 oasc.SolrConfig.refreshRequestParams current version
of requestparams : -1
[junit4] 2> 13658 T44 oasc.SolrConfig.<init> Using Lucene MatchVersion:
6.0.0
[junit4] 2> 13898 T44 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 13947 T44 oass.IndexSchema.readSchema Reading Solr Schema from
/configs/conf1/schema.xml
[junit4] 2> 14158 T44 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 15623 T44 oass.OpenExchangeRatesOrgProvider.init Initialized
with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 15672 T44 oass.IndexSchema.readSchema default search field in
schema is text
[junit4] 2> 15674 T44 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 16509 T44 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 16524 T44 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 16533 T44 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 16545 T44
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 16545 T44
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 16546 T44 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 16550 T44
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 16550 T44
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 16568 T44 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection control_collection
[junit4] 2> 16749 T44 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 16772 T44 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/control-001/cores/collection1/,
dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/tempDir-001/control/data/
[junit4] 2> 16782 T44 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@35e122cc
[junit4] 2> 17027 T44 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/tempDir-001/control/data
[junit4] 2> 17028 T44 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/tempDir-001/control/data/index/
[junit4] 2> 17029 T44 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/tempDir-001/control/data/index' doesn't exist. Creating
new index...
[junit4] 2> 17076 T44 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/tempDir-001/control/data/index
[junit4] 2> 17082 T44 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 17341 T44 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@75c3f778
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e10b0a9),segFN=segments_1,generation=1}
[junit4] 2> 17343 T44 oasc.SolrDeletionPolicy.updateCommits newest commit
generation = 1
[junit4] 2> 18329 T44 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 18438 T44 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 18455 T44 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 18455 T44 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 18456 T44 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 18456 T44 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 18572 T44 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 18573 T44 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 18573 T44 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 18656 T44 oasc.RequestHandlers.initHandlersFromConfig created
/update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 18658 T44 oasc.RequestHandlers.initHandlersFromConfig created
/update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 18659 T44 oasc.RequestHandlers.initHandlersFromConfig created
/update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 18661 T44 oasc.RequestHandlers.initHandlersFromConfig created
/update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 18664 T44 oasc.RequestHandlers.initHandlersFromConfig created
/config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 18668 T44 oasc.RequestHandlers.initHandlersFromConfig created
/schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 18703 T44 oasc.RequestHandlers.initHandlersFromConfig created
/replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 18710 T44 oasc.RequestHandlers.initHandlersFromConfig created
/get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 18713 T44 oasc.RequestHandlers.initHandlersFromConfig created
/admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 18718 T44 oasc.RequestHandlers.initHandlersFromConfig created
/admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 18720 T44 oasc.RequestHandlers.initHandlersFromConfig created
/admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 18721 T44 oasc.RequestHandlers.initHandlersFromConfig created
/admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 18723 T44 oasc.RequestHandlers.initHandlersFromConfig created
/admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 18724 T44 oasc.RequestHandlers.initHandlersFromConfig created
/admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 18725 T44 oasc.RequestHandlers.initHandlersFromConfig created
/admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 18766 T44 oasc.RequestHandlers.initHandlersFromConfig created
/admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 18769 T44 oasc.RequestHandlers.initHandlersFromConfig created
/admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 18804 T44 oasc.RequestHandlers.initHandlersFromConfig created
standard: solr.StandardRequestHandler
[junit4] 2> 19003 T44 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 19029 T44 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 19032 T44 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 19034 T44 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 19037 T44 oasc.SolrCore.initStatsCache Using default
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 19161 T44 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 19168 T44 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 19172 T44 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=15,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=true, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5918691378609128]
[junit4] 2> 19185 T44 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@75c3f778
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e10b0a9),segFN=segments_1,generation=1}
[junit4] 2> 19185 T44 oasc.SolrDeletionPolicy.updateCommits newest commit
generation = 1
[junit4] 2> 19297 T44 oass.SolrIndexSearcher.<init> Opening
Searcher@7e8c94d3[collection1] main
[junit4] 2> 19341 T44 oascc.ZkStateReader.readConfigName Load collection
config from:/collections/control_collection
[junit4] 2> 19345 T44 oascc.ZkStateReader.readConfigName
path=/collections/control_collection configName=conf1 specified config exists
in ZooKeeper
[junit4] 2> 19346 T44 oasr.ManagedResourceStorage.newStorageIO Setting up
ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 19368 T44
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 19369 T44 oasr.RestManager.init Initializing RestManager with
initArgs: {}
[junit4] 2> 19517 T44 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 19519 T44
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 19520 T44 oasr.ManagedResourceStorage.load Loaded null at path
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 19520 T44 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 19734 T44 oash.ReplicationHandler.inform Commits will be
reserved for 10000
[junit4] 2> 19757 T44 oasc.CoreContainer.registerCore registering core:
collection1
[junit4] 2> 19767 T45 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@7e8c94d3[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 19769 T48 oasc.ZkController.register Register replica -
core:collection1 address:http://127.0.0.1:49206/eq_t
collection:control_collection shard:shard1
[junit4] 2> 19792 T11 oass.SolrDispatchFilter.init
user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 19798 T11 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 19847 T48 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/leader_elect/shard1/election
[junit4] 2> 19906 T48 oasc.ShardLeaderElectionContext.runLeaderProcess
Running the leader process for shard shard1
[junit4] 2> 19922 T11
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 19926 T11 oascc.ConnectionManager.waitForConnected Waiting for
client to connect to ZooKeeper
[junit4] 2> 19934 T51 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@4879ba6 name:ZooKeeperConnection
Watcher:127.0.0.1:49203/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 19936 T11 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 19937 T11 oascc.SolrZkClient.createZkACLProvider Using default
ZkACLProvider
[junit4] 2> 19939 T40 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 19942 T11
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 19944 T48
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 19945 T48 oasc.ShardLeaderElectionContext.runLeaderProcess I
may be the new leader - try and sync
[junit4] 2> 19948 T41 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection"} current state
version: 1
[junit4] 2> ASYNC NEW_CORE C0 name=collection1
org.apache.solr.core.SolrCore@1b6cd423
url=http://127.0.0.1:49206/eq_t/collection1 node=127.0.0.1:49206_eq_t
C0_STATE=coll:control_collection core:collection1 props:{core=collection1,
base_url=http://127.0.0.1:49206/eq_t, node_name=127.0.0.1:49206_eq_t,
state=down}
[junit4] 2> 19970 T48 C0 P49206 oasc.SyncStrategy.sync Sync replicas to
http://127.0.0.1:49206/eq_t/collection1/
[junit4] 2> 19980 T48 C0 P49206 oasc.SyncStrategy.syncReplicas Sync
Success - now sync replicas to me
[junit4] 2> 19983 T48 C0 P49206 oasc.SyncStrategy.syncToMe
http://127.0.0.1:49206/eq_t/collection1/ has no replicas
[junit4] 2> 19992 T40 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 19991 T51 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 0)
[junit4] 2> 19993 T48 oasc.ShardLeaderElectionContext.runLeaderProcess I
am the new leader: http://127.0.0.1:49206/eq_t/collection1/ shard1
[junit4] 2> 20013 T48 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/leaders/shard1
[junit4] 2> 20064 T11 oasc.ChaosMonkey.monkeyLog monkey: init - expire
sessions:false cause connection loss:false
[junit4] 2> 20064 T11 oasc.AbstractFullDistribZkTestBase.createJettys
Creating collection1 with stateFormat=2
[junit4] 2> 20065 T11
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 20078 T54 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@560a05cb
name:ZooKeeperConnection Watcher:127.0.0.1:49203/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 20090 T11 oascc.ConnectionManager.waitForConnected Waiting for
client to connect to ZooKeeper
[junit4] 2> 20091 T11 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 20093 T11 oascc.SolrZkClient.createZkACLProvider Using default
ZkACLProvider
[junit4] 2> 20133 T55 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 20170 T41 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 2, message = {
[junit4] 2> "operation":"create",
[junit4] 2> "name":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "stateFormat":"2"} current state version: 2
[junit4] 2> 20171 T41 oasco.ClusterStateMutator.createCollection building
a new cName: collection1
[junit4] 2> 20196 T41 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "base_url":"http://127.0.0.1:49206/eq_t";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 2
[junit4] 2> 20203 T41 oasco.ZkStateWriter.writePendingUpdates going to
create_collection /collections/collection1/state.json
[junit4] 2> 20218 T51 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 20247 T55 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 20357 T51 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 20436 T48 oasc.ZkController.register We are
http://127.0.0.1:49206/eq_t/collection1/ and leader is
http://127.0.0.1:49206/eq_t/collection1/
[junit4] 2> 20444 T48 oasc.ZkController.register No LogReplay needed for
core=collection1 baseURL=http://127.0.0.1:49206/eq_t
[junit4] 2> 20444 T48 oasc.ZkController.checkRecovery I am the leader, no
recovery necessary
[junit4] 2> 20445 T48 oasc.ZkController.publish publishing
core=collection1 state=active collection=control_collection
[junit4] 2> 20445 T48 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 20463 T40 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 20521 T41 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49206/eq_t";,
[junit4] 2> "node_name":"127.0.0.1:49206_eq_t",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"} current state version: 4
[junit4] 2> 20522 T41 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49206/eq_t";,
[junit4] 2> "node_name":"127.0.0.1:49206_eq_t",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 20669 T51 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 20670 T40 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 22293 T11 oas.SolrTestCaseJ4.writeCoreProperties Writing
core.properties file to
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/shard-1-001/cores/collection1
[junit4] 2> 22305 T11 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1
[junit4] 2> 22309 T11 oejs.Server.doStart jetty-9.2.6.v20141205
[junit4] 2> 22316 T11 oejsh.ContextHandler.doStart Started
o.e.j.s.ServletContextHandler@3029c72d{/eq_t,null,AVAILABLE}
[junit4] 2> 22318 T11 oejs.AbstractConnector.doStart Started
ServerConnector@6e83ca70{HTTP/1.1}{127.0.0.1:49211}
[junit4] 2> 22319 T11 oejs.Server.doStart Started @26462ms
[junit4] 2> 22319 T11 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@4554617c
[junit4] 2> 22320 T11 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 22320 T11 oasc.SolrResourceLoader.locateSolrHome using system
property solr.solr.home:
../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/shard-1-001
[junit4] 2> 22321 T11 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/shard-1-001/'
[junit4] 2> 22378 T11 oasc.ConfigSolr.fromFile Loading container
configuration from
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/shard-1-001/solr.xml
[junit4] 2> 22396 T11 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/shard-1-001/cores
[junit4] 2> 22398 T11 oasc.CoreContainer.<init> New CoreContainer 53882794
[junit4] 2> 22399 T11 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/shard-1-001/]
[junit4] 2> 22400 T11 oashc.HttpShardHandlerFactory.getParameter Setting
socketTimeout to: 90000
[junit4] 2> 22400 T11 oashc.HttpShardHandlerFactory.getParameter Setting
urlScheme to:
[junit4] 2> 22400 T11 oashc.HttpShardHandlerFactory.getParameter Setting
connTimeout to: 15000
[junit4] 2> 22401 T11 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnectionsPerHost to: 20
[junit4] 2> 22402 T11 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnections to: 10000
[junit4] 2> 22402 T11 oashc.HttpShardHandlerFactory.getParameter Setting
corePoolSize to: 0
[junit4] 2> 22403 T11 oashc.HttpShardHandlerFactory.getParameter Setting
maximumPoolSize to: 2147483647
[junit4] 2> 22403 T11 oashc.HttpShardHandlerFactory.getParameter Setting
maxThreadIdleTime to: 5
[junit4] 2> 22404 T11 oashc.HttpShardHandlerFactory.getParameter Setting
sizeOfQueue to: -1
[junit4] 2> 22404 T11 oashc.HttpShardHandlerFactory.getParameter Setting
fairnessPolicy to: false
[junit4] 2> 22404 T11 oashc.HttpShardHandlerFactory.getParameter Setting
useRetries to: false
[junit4] 2> 22405 T11 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 22406 T11 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 22406 T11 oasl.LogWatcher.newRegisteredLogWatcher Registering
Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 22407 T11 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 22407 T11 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:49203/solr
[junit4] 2> 22407 T11 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 22408 T11
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 22423 T11 oascc.ConnectionManager.waitForConnected Waiting for
client to connect to ZooKeeper
[junit4] 2> 22430 T69 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@4a8adefd
name:ZooKeeperConnection Watcher:127.0.0.1:49203 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 22431 T11 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 22431 T11 oascc.SolrZkClient.createZkACLProvider Using default
ZkACLProvider
[junit4] 2> 22439 T11 oascc.ConnectionManager.waitForConnected Waiting for
client to connect to ZooKeeper
[junit4] 2> 22445 T72 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@3fd4041 name:ZooKeeperConnection
Watcher:127.0.0.1:49203/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 22445 T11 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 22473 T11
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 23495 T11 oasc.ZkController.createEphemeralLiveNode Register
node as live in ZooKeeper:/live_nodes/127.0.0.1:49211_eq_t
[junit4] 2> 23499 T11 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:49211_eq_t
[junit4] 2> 23518 T11 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 23531 T11 oasc.CorePropertiesLocator.discover Looking for core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/shard-1-001/cores
[junit4] 2> 23533 T11 oasc.CorePropertiesLocator.discoverUnder Found core
collection1 in
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/shard-1-001/cores/collection1/
[junit4] 2> 23534 T11 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 23543 T73 oasc.ZkController.publish publishing
core=collection1 state=down collection=collection1
[junit4] 2> 23543 T73 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 23552 T73 oasc.ZkController.preRegister Registering watch for
external collection collection1
[junit4] 2> 23553 T73 oascc.ZkStateReader.addZkWatch addZkWatch collection1
[junit4] 2> 23554 T73 oascc.ZkStateReader.addZkWatch Updating collection
state at /collections/collection1/state.json from ZooKeeper...
[junit4] 2> 23559 T40 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 23562 T41 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49211/eq_t";,
[junit4] 2> "node_name":"127.0.0.1:49211_eq_t",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"} current state version: 5
[junit4] 2> 23563 T41 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49211/eq_t";,
[junit4] 2> "node_name":"127.0.0.1:49211_eq_t",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"}
[junit4] 2> 23563 T41 oasco.ReplicaMutator.updateState Collection already
exists with numShards=2
[junit4] 2> 23563 T41 oasco.ReplicaMutator.updateState Assigning new node
to shard shard=shard2
[junit4] 2> 23580 T41 oasco.ZkStateWriter.writePendingUpdates going to
update_collection /collections/collection1/state.json version: 0
[junit4] 2> 23582 T73 oascc.ZkStateReader.updateWatchedCollection Updating
data for collection1 to ver 0
[junit4] 2> 23583 T73 oasc.ZkController.waitForCoreNodeName look for our
core node name
[junit4] 2> 23584 T72 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 23586 T72 oascc.ZkStateReader.updateWatchedCollection Updating
data for collection1 to ver 1
[junit4] 2> 24584 T73 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for collection1
[junit4] 2> 24585 T73 oasc.ZkController.createCollectionZkNode Check for
collection zkNode:collection1
[junit4] 2> 24589 T73 oasc.ZkController.createCollectionZkNode Collection
zkNode exists
[junit4] 2> 24590 T73 oascc.ZkStateReader.readConfigName Load collection
config from:/collections/collection1
[junit4] 2> 24598 T73 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 24599 T73 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/shard-1-001/cores/collection1/'
[junit4] 2> 24627 T73 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 24633 T73 oasc.Config.<init> loaded config solrconfig.xml with
version 0
[junit4] 2> 24709 T73 oasc.SolrConfig.refreshRequestParams current version
of requestparams : -1
[junit4] 2> 24722 T73 oasc.SolrConfig.<init> Using Lucene MatchVersion:
6.0.0
[junit4] 2> 24747 T73 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 24752 T73 oass.IndexSchema.readSchema Reading Solr Schema from
/configs/conf1/schema.xml
[junit4] 2> 24875 T73 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 25138 T73 oass.OpenExchangeRatesOrgProvider.init Initialized
with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 25170 T73 oass.IndexSchema.readSchema default search field in
schema is text
[junit4] 2> 25174 T73 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 25247 T73 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 25268 T73 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 25278 T73 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 25285 T73
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 25286 T73
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 25288 T73 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 25293 T73
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 25293 T73
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 25294 T73 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection collection1
[junit4] 2> 25294 T73 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 25295 T73 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/shard-1-001/cores/collection1/,
dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/tempDir-001/jetty1/
[junit4] 2> 25296 T73 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@35e122cc
[junit4] 2> 25301 T73 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/tempDir-001/jetty1
[junit4] 2> 25302 T73 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/tempDir-001/jetty1/index/
[junit4] 2> 25302 T73 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/tempDir-001/jetty1/index' doesn't exist. Creating new
index...
[junit4] 2> 25303 T73 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/tempDir-001/jetty1/index
[junit4] 2> 25303 T73 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 25305 T73 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@3772eb31
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4155dc9d),segFN=segments_1,generation=1}
[junit4] 2> 25306 T73 oasc.SolrDeletionPolicy.updateCommits newest commit
generation = 1
[junit4] 2> 25323 T73 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 25324 T73 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 25325 T73 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 25325 T73 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 25326 T73 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 25326 T73 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 25327 T73 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 25328 T73 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 25328 T73 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 25334 T73 oasc.RequestHandlers.initHandlersFromConfig created
/update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 25349 T73 oasc.RequestHandlers.initHandlersFromConfig created
/update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 25351 T73 oasc.RequestHandlers.initHandlersFromConfig created
/update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 25353 T73 oasc.RequestHandlers.initHandlersFromConfig created
/update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 25354 T73 oasc.RequestHandlers.initHandlersFromConfig created
/config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 25356 T73 oasc.RequestHandlers.initHandlersFromConfig created
/schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 25368 T73 oasc.RequestHandlers.initHandlersFromConfig created
/replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 25371 T73 oasc.RequestHandlers.initHandlersFromConfig created
/get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 25373 T73 oasc.RequestHandlers.initHandlersFromConfig created
/admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 25378 T73 oasc.RequestHandlers.initHandlersFromConfig created
/admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 25380 T73 oasc.RequestHandlers.initHandlersFromConfig created
/admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 25384 T73 oasc.RequestHandlers.initHandlersFromConfig created
/admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 25385 T73 oasc.RequestHandlers.initHandlersFromConfig created
/admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 25387 T73 oasc.RequestHandlers.initHandlersFromConfig created
/admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 25388 T73 oasc.RequestHandlers.initHandlersFromConfig created
/admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 25390 T73 oasc.RequestHandlers.initHandlersFromConfig created
/admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 25394 T73 oasc.RequestHandlers.initHandlersFromConfig created
/admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 25396 T73 oasc.RequestHandlers.initHandlersFromConfig created
standard: solr.StandardRequestHandler
[junit4] 2> 25408 T73 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 25410 T73 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 25412 T73 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 25422 T73 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 25424 T73 oasc.SolrCore.initStatsCache Using default
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 25428 T73 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 25428 T73 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 25431 T73 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=15,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=true, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5918691378609128]
[junit4] 2> 25433 T73 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@3772eb31
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4155dc9d),segFN=segments_1,generation=1}
[junit4] 2> 25433 T73 oasc.SolrDeletionPolicy.updateCommits newest commit
generation = 1
[junit4] 2> 25434 T73 oass.SolrIndexSearcher.<init> Opening
Searcher@4f8a4919[collection1] main
[junit4] 2> 25435 T73 oascc.ZkStateReader.readConfigName Load collection
config from:/collections/collection1
[junit4] 2> 25441 T73 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 25441 T73 oasr.ManagedResourceStorage.newStorageIO Setting up
ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 25443 T73
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 25443 T73 oasr.RestManager.init Initializing RestManager with
initArgs: {}
[junit4] 2> 25443 T73 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 25445 T73
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 25446 T73 oasr.ManagedResourceStorage.load Loaded null at path
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 25446 T73 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 25446 T73 oash.ReplicationHandler.inform Commits will be
reserved for 10000
[junit4] 2> 25449 T74 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@4f8a4919[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 25451 T73 oasc.CoreContainer.registerCore registering core:
collection1
[junit4] 2> 25453 T77 oasc.ZkController.register Register replica -
core:collection1 address:http://127.0.0.1:49211/eq_t collection:collection1
shard:shard2
[junit4] 2> 25456 T11 oass.SolrDispatchFilter.init
user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 25456 T11 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 25470 T77 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leader_elect/shard2/election
[junit4] 2> 25490 T77 oasc.ShardLeaderElectionContext.runLeaderProcess
Running the leader process for shard shard2
[junit4] 2> 25495 T40 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 25499 T77
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 25499 T77 oasc.ShardLeaderElectionContext.runLeaderProcess I
may be the new leader - try and sync
[junit4] 2> ASYNC NEW_CORE C1 name=collection1
org.apache.solr.core.SolrCore@5463410
url=http://127.0.0.1:49211/eq_t/collection1 node=127.0.0.1:49211_eq_t
C1_STATE=coll:collection1 core:collection1 props:{core=collection1,
base_url=http://127.0.0.1:49211/eq_t, node_name=127.0.0.1:49211_eq_t,
state=down}
[junit4] 2> 25500 T77 C1 P49211 oasc.SyncStrategy.sync Sync replicas to
http://127.0.0.1:49211/eq_t/collection1/
[junit4] 2> 25501 T77 C1 P49211 oasc.SyncStrategy.syncReplicas Sync
Success - now sync replicas to me
[junit4] 2> 25501 T77 C1 P49211 oasc.SyncStrategy.syncToMe
http://127.0.0.1:49211/eq_t/collection1/ has no replicas
[junit4] 2> 25501 T77 oasc.ShardLeaderElectionContext.runLeaderProcess I
am the new leader: http://127.0.0.1:49211/eq_t/collection1/ shard2
[junit4] 2> 25502 T77 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leaders/shard2
[junit4] 2> 25503 T41 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"collection1"} current state version: 5
[junit4] 2> 25509 T41 oasco.ZkStateWriter.writePendingUpdates going to
update_collection /collections/collection1/state.json version: 1
[junit4] 2> 25515 T72 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 25520 T72 oascc.ZkStateReader.updateWatchedCollection Updating
data for collection1 to ver 2
[junit4] 2> 25532 T41 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "base_url":"http://127.0.0.1:49211/eq_t";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 5
[junit4] 2> 25536 T41 oasco.ZkStateWriter.writePendingUpdates going to
update_collection /collections/collection1/state.json version: 2
[junit4] 2> 25539 T72 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 25541 T72 oascc.ZkStateReader.updateWatchedCollection Updating
data for collection1 to ver 3
[junit4] 2> 25562 T40 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 25584 T77 oasc.ZkController.register We are
http://127.0.0.1:49211/eq_t/collection1/ and leader is
http://127.0.0.1:49211/eq_t/collection1/
[junit4] 2> 25586 T77 oasc.ZkController.register No LogReplay needed for
core=collection1 baseURL=http://127.0.0.1:49211/eq_t
[junit4] 2> 25586 T77 oasc.ZkController.checkRecovery I am the leader, no
recovery necessary
[junit4] 2> 25587 T77 oasc.ZkController.publish publishing
core=collection1 state=active collection=collection1
[junit4] 2> 25587 T77 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 25592 T40 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 25609 T41 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49211/eq_t";,
[junit4] 2> "node_name":"127.0.0.1:49211_eq_t",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"} current state version: 5
[junit4] 2> 25625 T41 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49211/eq_t";,
[junit4] 2> "node_name":"127.0.0.1:49211_eq_t",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"}
[junit4] 2> 25631 T41 oasco.ZkStateWriter.writePendingUpdates going to
update_collection /collections/collection1/state.json version: 3
[junit4] 2> 25643 T72 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 25645 T77 oascc.ZkStateReader.updateWatchedCollection Updating
data for collection1 to ver 4
[junit4] 2> 25651 T72 oascc.ZkStateReader.updateWatchedCollection Updating
data for collection1 to ver 4
[junit4] 2> 27339 T11 oas.SolrTestCaseJ4.writeCoreProperties Writing
core.properties file to
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/shard-2-001/cores/collection1
[junit4] 2> 27342 T11 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2
[junit4] 2> 27343 T11 oejs.Server.doStart jetty-9.2.6.v20141205
[junit4] 2> 27351 T11 oejsh.ContextHandler.doStart Started
o.e.j.s.ServletContextHandler@686feeb9{/eq_t,null,AVAILABLE}
[junit4] 2> 27352 T11 oejs.AbstractConnector.doStart Started
ServerConnector@701906f5{HTTP/1.1}{127.0.0.1:49214}
[junit4] 2> 27352 T11 oejs.Server.doStart Started @31495ms
[junit4] 2> 27353 T11 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@4554617c
[junit4] 2> 27354 T11 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 27354 T11 oasc.SolrResourceLoader.locateSolrHome using system
property solr.solr.home:
../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/shard-2-001
[junit4] 2> 27355 T11 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/shard-2-001/'
[junit4] 2> 27406 T11 oasc.ConfigSolr.fromFile Loading container
configuration from
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/shard-2-001/solr.xml
[junit4] 2> 27423 T11 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/shard-2-001/cores
[junit4] 2> 27426 T11 oasc.CoreContainer.<init> New CoreContainer 741778657
[junit4] 2> 27427 T11 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/shard-2-001/]
[junit4] 2> 27429 T11 oashc.HttpShardHandlerFactory.getParameter Setting
socketTimeout to: 90000
[junit4] 2> 27430 T11 oashc.HttpShardHandlerFactory.getParameter Setting
urlScheme to:
[junit4] 2> 27431 T11 oashc.HttpShardHandlerFactory.getParameter Setting
connTimeout to: 15000
[junit4] 2> 27431 T11 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnectionsPerHost to: 20
[junit4] 2> 27432 T11 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnections to: 10000
[junit4] 2> 27433 T11 oashc.HttpShardHandlerFactory.getParameter Setting
corePoolSize to: 0
[junit4] 2> 27434 T11 oashc.HttpShardHandlerFactory.getParameter Setting
maximumPoolSize to: 2147483647
[junit4] 2> 27434 T11 oashc.HttpShardHandlerFactory.getParameter Setting
maxThreadIdleTime to: 5
[junit4] 2> 27435 T11 oashc.HttpShardHandlerFactory.getParameter Setting
sizeOfQueue to: -1
[junit4] 2> 27435 T11 oashc.HttpShardHandlerFactory.getParameter Setting
fairnessPolicy to: false
[junit4] 2> 27435 T11 oashc.HttpShardHandlerFactory.getParameter Setting
useRetries to: false
[junit4] 2> 27436 T11 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 27436 T11 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 27437 T11 oasl.LogWatcher.newRegisteredLogWatcher Registering
Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 27437 T11 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 27438 T11 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:49203/solr
[junit4] 2> 27439 T11 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 27439 T11
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 27443 T11 oascc.ConnectionManager.waitForConnected Waiting for
client to connect to ZooKeeper
[junit4] 2> 27452 T91 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@128d14d7
name:ZooKeeperConnection Watcher:127.0.0.1:49203 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 27453 T11 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 27454 T11 oascc.SolrZkClient.createZkACLProvider Using default
ZkACLProvider
[junit4] 2> 27460 T11 oascc.ConnectionManager.waitForConnected Waiting for
client to connect to ZooKeeper
[junit4] 2> 27465 T94 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@79a70c39
name:ZooKeeperConnection Watcher:127.0.0.1:49203/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 27466 T11 oascc.ConnectionManager.waitForConnected Client is
connected to ZooKeeper
[junit4] 2> 27491 T11
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 28515 T11 oasc.ZkController.createEphemeralLiveNode Register
node as live in ZooKeeper:/live_nodes/127.0.0.1:49214_eq_t
[junit4] 2> 28519 T11 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:49214_eq_t
[junit4] 2> 28535 T11 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 28543 T11 oasc.CorePropertiesLocator.discover Looking for core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/shard-2-001/cores
[junit4] 2> 28546 T11 oasc.CorePropertiesLocator.discoverUnder Found core
collection1 in
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/shard-2-001/cores/collection1/
[junit4] 2> 28546 T11 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 28556 T95 oasc.ZkController.publish publishing
core=collection1 state=down collection=collection1
[junit4] 2> 28556 T95 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 28578 T40 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 28584 T41 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49214/eq_t";,
[junit4] 2> "node_name":"127.0.0.1:49214_eq_t",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"} current state version: 5
[junit4] 2> 28586 T41 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49214/eq_t";,
[junit4] 2> "node_name":"127.0.0.1:49214_eq_t",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"}
[junit4] 2> 28587 T41 oasco.ReplicaMutator.updateState Collection already
exists with numShards=2
[junit4] 2> 28590 T41 oasco.ReplicaMutator.updateState Assigning new node
to shard shard=shard1
[junit4] 2> 28596 T41 oasco.ZkStateWriter.writePendingUpdates going to
update_collection /collections/collection1/state.json version: 4
[junit4] 2> 28597 T95 oasc.ZkController.preRegister Registering watch for
external collection collection1
[junit4] 2> 28599 T95 oascc.ZkStateReader.addZkWatch addZkWatch collection1
[junit4] 2> 28600 T72 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 28602 T72 oascc.ZkStateReader.updateWatchedCollection Updating
data for collection1 to ver 5
[junit4] 2> 28603 T95 oascc.ZkStateReader.addZkWatch Updating collection
state at /collections/collection1/state.json from ZooKeeper...
[junit4] 2> 28607 T95 oascc.ZkStateReader.updateWatchedCollection Updating
data for collection1 to ver 5
[junit4] 2> 28607 T95 oasc.ZkController.waitForCoreNodeName look for our
core node name
[junit4] 2> 28607 T95 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for collection1
[junit4] 2> 28607 T95 oasc.ZkController.createCollectionZkNode Check for
collection zkNode:collection1
[junit4] 2> 28609 T95 oasc.ZkController.createCollectionZkNode Collection
zkNode exists
[junit4] 2> 28610 T95 oascc.ZkStateReader.readConfigName Load collection
config from:/collections/collection1
[junit4] 2> 28613 T95 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 28613 T95 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/shard-2-001/cores/collection1/'
[junit4] 2> 28646 T95 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 28666 T95 oasc.Config.<init> loaded config solrconfig.xml with
version 0
[junit4] 2> 28707 T95 oasc.SolrConfig.refreshRequestParams current version
of requestparams : -1
[junit4] 2> 28716 T95 oasc.SolrConfig.<init> Using Lucene MatchVersion:
6.0.0
[junit4] 2> 28732 T95 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 28737 T95 oass.IndexSchema.readSchema Reading Solr Schema from
/configs/conf1/schema.xml
[junit4] 2> 28765 T95 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 28990 T95 oass.OpenExchangeRatesOrgProvider.init Initialized
with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 29007 T95 oass.IndexSchema.readSchema default search field in
schema is text
[junit4] 2> 29013 T95 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 29080 T95 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 29092 T95 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 29098 T95 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 29102 T95
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 29103 T95
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 29103 T95 oass.OpenExchangeRatesOrgProvider.reload Reloading
exchange rates from open-exchange-rates.json
[junit4] 2> 29105 T95
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 29106 T95
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 29106 T95 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection collection1
[junit4] 2> 29106 T95 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 29107 T95 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/shard-2-001/cores/collection1/,
dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/tempDir-001/jetty2/
[junit4] 2> 29107 T95 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@35e122cc
[junit4] 2> 29108 T95 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/tempDir-001/jetty2
[junit4] 2> 29109 T95 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/tempDir-001/jetty2/index/
[junit4] 2> 29109 T95 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/tempDir-001/jetty2/index' doesn't exist. Creating new
index...
[junit4] 2> 29110 T95 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/tempDir-001/jetty2/index
[junit4] 2> 29110 T95 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 29114 T95 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@7bcf2830
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ae20f9d),segFN=segments_1,generation=1}
[junit4] 2> 29114 T95 oasc.SolrDeletionPolicy.updateCommits newest commit
generation = 1
[junit4] 2> 29136 T95 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 29137 T95 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 29137 T95 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 29140 T95 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 29141 T95 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 29141 T95 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 29154 T95 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 29155 T95 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 29155 T95 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 29156 T95 oasc.RequestHandlers.initHandlersFromConfig created
/update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 29158 T95 oasc.RequestHandlers.initHandlersFromConfig created
/update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 29159 T95 oasc.RequestHandlers.initHandlersFromConfig created
/update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 29160 T95 oasc.RequestHandlers.initHandlersFromConfig created
/update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 29161 T95 oasc.RequestHandlers.initHandlersFromConfig created
/config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 29174 T95 oasc.RequestHandlers.initHandlersFromConfig created
/schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 29193 T95 oasc.RequestHandlers.initHandlersFromConfig created
/replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 29196 T95 oasc.RequestHandlers.initHandlersFromConfig created
/get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 29197 T95 oasc.RequestHandlers.initHandlersFromConfig created
/admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 29207 T95 oasc.RequestHandlers.initHandlersFromConfig created
/admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 29209 T95 oasc.RequestHandlers.initHandlersFromConfig created
/admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 29211 T95 oasc.RequestHandlers.initHandlersFromConfig created
/admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 29213 T95 oasc.RequestHandlers.initHandlersFromConfig created
/admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 29216 T95 oasc.RequestHandlers.initHandlersFromConfig created
/admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 29220 T95 oasc.RequestHandlers.initHandlersFromConfig created
/admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 29221 T95 oasc.RequestHandlers.initHandlersFromConfig created
/admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 29222 T95 oasc.RequestHandlers.initHandlersFromConfig created
/admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 29223 T95 oasc.RequestHandlers.initHandlersFromConfig created
standard: solr.StandardRequestHandler
[junit4] 2> 29232 T95 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 29235 T95 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 29236 T95 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 29239 T95 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 29240 T95 oasc.SolrCore.initStatsCache Using default
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 29244 T95 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 29244 T95 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 29247 T95 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=15,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=true, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5918691378609128]
[junit4] 2> 29248 T95 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@7bcf2830
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ae20f9d),segFN=segments_1,generation=1}
[junit4] 2> 29248 T95 oasc.SolrDeletionPolicy.updateCommits newest commit
generation = 1
[junit4] 2> 29249 T95 oass.SolrIndexSearcher.<init> Opening
Searcher@56374d39[collection1] main
[junit4] 2> 29250 T95 oascc.ZkStateReader.readConfigName Load collection
config from:/collections/collection1
[junit4] 2> 29255 T95 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 29256 T95 oasr.ManagedResourceStorage.newStorageIO Setting up
ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 29260 T95
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 29260 T95 oasr.RestManager.init Initializing RestManager with
initArgs: {}
[junit4] 2> 29262 T95 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 29263 T95
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 29264 T95 oasr.ManagedResourceStorage.load Loaded null at path
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 29264 T95 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 29264 T95 oash.ReplicationHandler.inform Commits will be
reserved for 10000
[junit4] 2> 29267 T96 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@56374d39[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 29268 T95 oasc.CoreContainer.registerCore registering core:
collection1
[junit4] 2> 29271 T99 oasc.ZkController.register Register replica -
core:collection1 address:http://127.0.0.1:49214/eq_t collection:collection1
shard:shard1
[junit4] 2> 29274 T11 oass.SolrDispatchFilter.init
user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 29274 T11 oass.SolrDispatchFilter.init SolrDispatchFilter.
[...truncated too long message...]
hard1
[junit4] 2> 52277 T141 oasc.SolrCore.close [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@3623b403
[junit4] 2> 52277 T141 oasc.ZkController.unRegisterConfListener a
listener was removed because of core close
[junit4] 2> 52277 T141 oasu.DirectUpdateHandler2.close closing
DirectUpdateHandler2{commits=0,autocommits=0,soft
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
[junit4] 2> 52277 T141 oasu.SolrCoreState.decrefSolrCoreState Closing
SolrCoreState
[junit4] 2> 52277 T141 oasu.DefaultSolrCoreState.closeIndexWriter
SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 52278 T141 oasu.DefaultSolrCoreState.closeIndexWriter closing
IndexWriter with IndexWriterCloser
[junit4] 2> 52287 T141 oasc.SolrCore.closeSearcher [collection1] Closing
main searcher on request.
[junit4] 2> 52323 T141 oasc.CachingDirectoryFactory.close Closing
MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 52323 T141 oasc.CachingDirectoryFactory.closeCacheValue
looking to close
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/tempDir-001/jetty4
[CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/tempDir-001/jetty4;done=false>>]
[junit4] 2> 52324 T141 oasc.CachingDirectoryFactory.close Closing
directory:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/tempDir-001/jetty4
[junit4] 2> 52324 T141 oasc.CachingDirectoryFactory.closeCacheValue
looking to close
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/tempDir-001/jetty4/index
[CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/tempDir-001/jetty4/index;done=false>>]
[junit4] 2> 52324 T141 oasc.CachingDirectoryFactory.close Closing
directory:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001/tempDir-001/jetty4/index
[junit4] 2> 52324 T141 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leaders/shard1
[junit4] 2> 52325 T141 oasc.SolrException.log ERROR There was a problem
trying to register as the leader:org.apache.solr.common.SolrException: Could
not register as the leader because creating the ephemeral registration node in
ZooKeeper failed
[junit4] 2> at
org.apache.solr.cloud.ShardLeaderElectionContextBase.runLeaderProcess(ElectionContext.java:147)
[junit4] 2> at
org.apache.solr.cloud.ShardLeaderElectionContext.runLeaderProcess(ElectionContext.java:308)
[junit4] 2> at
org.apache.solr.cloud.LeaderElector.runIamLeaderProcess(LeaderElector.java:198)
[junit4] 2> at
org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:159)
[junit4] 2> at
org.apache.solr.cloud.LeaderElector.access$200(LeaderElector.java:56)
[junit4] 2> at
org.apache.solr.cloud.LeaderElector$ElectionWatcher.process(LeaderElector.java:390)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$3$1.run(SolrZkClient.java:263)
[junit4] 2> at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at
java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> Caused by:
org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode =
Session expired for /collections
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at
org.apache.zookeeper.ZooKeeper.exists(ZooKeeper.java:1045)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$4.execute(SolrZkClient.java:293)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$4.execute(SolrZkClient.java:290)
[junit4] 2> at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:61)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.exists(SolrZkClient.java:290)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.makePath(SolrZkClient.java:485)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.makePath(SolrZkClient.java:454)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.makePath(SolrZkClient.java:441)
[junit4] 2> at
org.apache.solr.cloud.ShardLeaderElectionContextBase$1.execute(ElectionContext.java:139)
[junit4] 2> at
org.apache.solr.common.util.RetryUtil.retryOnThrowable(RetryUtil.java:31)
[junit4] 2> at
org.apache.solr.cloud.ShardLeaderElectionContextBase.runLeaderProcess(ElectionContext.java:135)
[junit4] 2> ... 11 more
[junit4] 2>
[junit4] 2> 53633 T196 oascc.ZkStateReader$3.process WARN ZooKeeper watch
triggered, but Solr cannot talk to ZK
[junit4] 2> 53640 T11 oejs.AbstractConnector.doStop Stopped
ServerConnector@4e5138a5{HTTP/1.1}{127.0.0.1:0}
[junit4] 2> 53642 T11 oejsh.ContextHandler.doStop Stopped
o.e.j.s.ServletContextHandler@399ab8b1{/eq_t,null,UNAVAILABLE}
[junit4] 2> 53647 T11 oasc.ZkTestServer.send4LetterWord connecting to
127.0.0.1:49203 49203
[junit4] 2> 53687 T12 oasc.ZkTestServer.send4LetterWord connecting to
127.0.0.1:49203 49203
[junit4] 2> 54026 T12 oasc.ZkTestServer$ZKServerMain.runFromConfig WARN
Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 8 /solr/aliases.json
[junit4] 2> 8 /solr/clusterstate.json
[junit4] 2> 5 /solr/configs/conf1
[junit4] 2> 4 /solr/collections/collection1/state.json
[junit4] 2> 4 /solr/collections/delLiveColl/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 8 /solr/live_nodes
[junit4] 2> 5 /solr/overseer/collection-queue-work
[junit4] 2> 4 /solr/overseer/queue
[junit4] 2>
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=DeleteReplicaTest
-Dtests.method=deleteLiveReplicaTest -Dtests.seed=BAEC14A249145254
-Dtests.slow=true -Dtests.locale=ru -Dtests.timezone=Asia/Urumqi
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] FAILURE 51.2s | DeleteReplicaTest.deleteLiveReplicaTest <<<
[junit4] > Throwable #1: java.lang.AssertionError: Should have had a good
message here
[junit4] > at
__randomizedtesting.SeedInfo.seed([BAEC14A249145254:178CA0A9542BFA21]:0)
[junit4] > at
org.apache.solr.cloud.DeleteReplicaTest.deleteLiveReplicaTest(DeleteReplicaTest.java:125)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:940)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:915)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 54089 T11 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
BAEC14A249145254-001
[junit4] 2> 52041 T10 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will
linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {},
docValues:{}, sim=DefaultSimilarity, locale=ru, timezone=Asia/Urumqi
[junit4] 2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.8.0_31
(64-bit)/cpus=2,threads=1,free=108347064,total=220725248
[junit4] 2> NOTE: All tests run in this JVM: [DeleteReplicaTest]
[junit4] Completed in 55.09s, 1 test, 1 failure <<< FAILURES!
[...truncated 1443 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:519: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:467: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:61: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/extra-targets.xml:39: The
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build.xml:191: The
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/common-build.xml:510:
The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:1348:
The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:956:
There were test failures: 464 suites, 1854 tests, 1 failure, 51 ignored (20
assumptions)
Total time: 129 minutes 15 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.8.0
-XX:-UseCompressedOops -XX:+UseParallelGC
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]
