Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-MacOSX/1999/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseG1GC
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([6CB9F97D2A824137:C1D94D7637BDE942]: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:120)
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 10154 lines...]
[junit4] Suite: org.apache.solr.cloud.DeleteReplicaTest
[junit4] 2> Creating dataDir:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
6CB9F97D2A824137-001/init-core-data-001
[junit4] 2> 3490364 T16052 oas.SolrTestCaseJ4.buildSSLConfig Randomized
ssl (false) and clientAuth (false)
[junit4] 2> 3490365 T16052
oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system
property: /
[junit4] 2> 3490370 T16052 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 3490372 T16053 oasc.ZkTestServer$ZKServerMain.runFromConfig
Starting server
[junit4] 2> 3490473 T16052 oasc.ZkTestServer.run start zk server on
port:52954
[junit4] 2> 3490473 T16052
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3490476 T16052 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3490484 T16060 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@63999d8a
name:ZooKeeperConnection Watcher:127.0.0.1:52954 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3490485 T16052 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3490486 T16052 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3490486 T16052 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 3490496 T16052
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3490498 T16052 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3490501 T16063 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@54586dda
name:ZooKeeperConnection Watcher:127.0.0.1:52954/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3490502 T16052 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3490502 T16052 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3490503 T16052 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 3490510 T16052 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 3490519 T16052 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 3490524 T16052 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 3490531 T16052 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> 3490532 T16052 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 3490543 T16052 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> 3490543 T16052 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 3490551 T16052 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> 3490552 T16052 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 3490559 T16052 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> 3490560 T16052 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 3490568 T16052 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> 3490568 T16052 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 3490574 T16052 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> 3490575 T16052 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 3490584 T16052 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> 3490584 T16052 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 3490592 T16052 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> 3490593 T16052 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 3490603 T16052 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> 3490604 T16052 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 3490611 T16052 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> 3490612 T16052 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 3490620 T16052 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> 3490621 T16052 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> 3492424 T16052 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
6CB9F97D2A824137-001/control-001/cores/collection1
[junit4] 2> 3492429 T16052 oejs.Server.doStart jetty-9.2.6.v20141205
[junit4] 2> 3492435 T16052 oejsh.ContextHandler.doStart Started
o.e.j.s.ServletContextHandler@69ecf66e{/,null,AVAILABLE}
[junit4] 2> 3492438 T16052 oejs.AbstractConnector.doStart Started
ServerConnector@49225e9e{HTTP/1.1}{127.0.0.1:52957}
[junit4] 2> 3492439 T16052 oejs.Server.doStart Started @3496817ms
[junit4] 2> 3492440 T16052 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@4554617c
[junit4] 2> 3492441 T16052 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 3492442 T16052 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
6CB9F97D2A824137-001/control-001
[junit4] 2> 3492442 T16052 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
6CB9F97D2A824137-001/control-001/'
[junit4] 2> 3492493 T16052 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
6CB9F97D2A824137-001/control-001/solr.xml
[junit4] 2> 3492505 T16052 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
6CB9F97D2A824137-001/control-001/cores
[junit4] 2> 3492506 T16052 oasc.CoreContainer.<init> New CoreContainer
1245933560
[junit4] 2> 3492506 T16052 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
6CB9F97D2A824137-001/control-001/]
[junit4] 2> 3492507 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 3492507 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 3492507 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 3492508 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 3492509 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 3492509 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 3492510 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 3492510 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 3492510 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 3492510 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 3492511 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting useRetries to: false
[junit4] 2> 3492511 T16052 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 3492512 T16052 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3492513 T16052 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3492513 T16052 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3492513 T16052 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:52954/solr
[junit4] 2> 3492514 T16052 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 3492514 T16052
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3492515 T16052 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3492519 T16077 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@505278a6
name:ZooKeeperConnection Watcher:127.0.0.1:52954 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3492519 T16052 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3492519 T16052 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3492525 T16052 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3492529 T16080 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5c0cbbbf
name:ZooKeeperConnection Watcher:127.0.0.1:52954/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3492530 T16052 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3492534 T16052 oascc.SolrZkClient.makePath makePath:
/overseer/queue
[junit4] 2> 3492543 T16052 oascc.SolrZkClient.makePath makePath:
/overseer/collection-queue-work
[junit4] 2> 3492553 T16052 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-running
[junit4] 2> 3492564 T16052 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-completed
[junit4] 2> 3492573 T16052 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-failure
[junit4] 2> 3492583 T16052 oascc.SolrZkClient.makePath makePath:
/live_nodes
[junit4] 2> 3492588 T16052 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52957_
[junit4] 2> 3492590 T16052 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:52957_
[junit4] 2> 3492598 T16052 oascc.SolrZkClient.makePath makePath:
/overseer_elect
[junit4] 2> 3492604 T16052 oascc.SolrZkClient.makePath makePath:
/overseer_elect/election
[junit4] 2> 3492611 T16052 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 3492614 T16052 oasc.OverseerElectionContext.runLeaderProcess I
am going to be the leader 127.0.0.1:52957_
[junit4] 2> 3492614 T16052 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 3492619 T16052 oasc.Overseer.start Overseer
(id=93324285497507843-127.0.0.1:52957_-n_0000000000) starting
[junit4] 2> 3492624 T16052 oascc.SolrZkClient.makePath makePath:
/overseer/queue-work
[junit4] 2> 3492649 T16052 oasc.OverseerAutoReplicaFailoverThread.<init>
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=10000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 3492651 T16082 oasc.OverseerCollectionProcessor.run Process
current queue of collection creations
[junit4] 2> 3492654 T16052 oascc.SolrZkClient.makePath makePath:
/clusterstate.json
[junit4] 2> 3492659 T16052 oascc.SolrZkClient.makePath makePath:
/aliases.json
[junit4] 2> 3492664 T16052
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 3492677 T16081 oasc.Overseer$ClusterStateUpdater.run Starting
to work on the main queue
[junit4] 2> 3492680 T16052 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
6CB9F97D2A824137-001/control-001/cores
[junit4] 2> 3492682 T16052 oasc.CorePropertiesLocator.discoverUnder Found
core collection1 in
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
6CB9F97D2A824137-001/control-001/cores/collection1/
[junit4] 2> 3492682 T16052 oasc.CorePropertiesLocator.discover Found 1
core definitions
[junit4] 2> 3492685 T16084 oasc.ZkController.publish publishing
core=collection1 state=down collection=control_collection
[junit4] 2> 3492686 T16084 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 3492687 T16080 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 3492687 T16084 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 3492698 T16081 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:52957";,
[junit4] 2> "node_name":"127.0.0.1:52957_",
[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> 3492700 T16081 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:52957";,
[junit4] 2> "node_name":"127.0.0.1:52957_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 3492700 T16081 oasco.ClusterStateMutator.createCollection
building a new cName: control_collection
[junit4] 2> 3492700 T16081 oasco.ReplicaMutator.updateState Assigning new
node to shard shard=shard1
[junit4] 2> 3492705 T16080 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> 3493690 T16084 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for collection1
[junit4] 2> 3493690 T16084 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:control_collection
[junit4] 2> 3493693 T16084 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 3493693 T16084 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/control_collection
[junit4] 2> 3493697 T16084 oascc.ZkStateReader.readConfigName
path=/collections/control_collection configName=conf1 specified config exists
in ZooKeeper
[junit4] 2> 3493697 T16084 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
6CB9F97D2A824137-001/control-001/cores/collection1/'
[junit4] 2> 3493723 T16084 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 3493727 T16084 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 3493740 T16084 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 3493745 T16084 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 6.0.0
[junit4] 2> 3493755 T16084 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 3493761 T16084 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 3493766 T16084 oass.IndexSchema.readSchema [collection1]
Schema name=test
[junit4] 2> 3493914 T16084 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3493920 T16084 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 3493922 T16084 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3493956 T16084 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3493962 T16084 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3493968 T16084 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3493971 T16084
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3493972 T16084
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3493972 T16084 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3493976 T16084
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3493976 T16084
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3493977 T16084 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection control_collection
[junit4] 2> 3493977 T16084 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3493978 T16084 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
6CB9F97D2A824137-001/control-001/cores/collection1/,
dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
6CB9F97D2A824137-001/tempDir-001/control/data/
[junit4] 2> 3493978 T16084 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7bebc24f
[junit4] 2> 3493979 T16084 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
6CB9F97D2A824137-001/tempDir-001/control/data
[junit4] 2> 3493979 T16084 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
6CB9F97D2A824137-001/tempDir-001/control/data/index/
[junit4] 2> 3493980 T16084 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
6CB9F97D2A824137-001/tempDir-001/control/data/index' doesn't exist. Creating
new index...
[junit4] 2> 3493981 T16084 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
6CB9F97D2A824137-001/tempDir-001/control/data/index
[junit4] 2> 3493982 T16084 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=27, maxMergeAtOnceExplicit=21, maxMergedSegmentMB=5.3818359375,
floorSegmentMB=0.24609375, forceMergeDeletesPctAllowed=1.0226153800254012,
segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.7018809781004215
[junit4] 2> 3493983 T16084 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@5cc70656
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e98128a),segFN=segments_1,generation=1}
[junit4] 2> 3493983 T16084 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 3493988 T16084 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 3493988 T16084 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 3493989 T16084 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe"
[junit4] 2> 3493989 T16084 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 3493989 T16084 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"stored_sig"
[junit4] 2> 3493990 T16084 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3493991 T16084 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3493991 T16084 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 3493991 T16084 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3493992 T16084 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3493993 T16084 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3493993 T16084 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3493994 T16084 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3493995 T16084 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 3493996 T16084 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 3493996 T16084 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 3493997 T16084 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 3493998 T16084 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 3494000 T16084 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 3494001 T16084 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 3494001 T16084 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 3494002 T16084 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 3494002 T16084 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 3494003 T16084 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 3494003 T16084 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 3494004 T16084 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 3494004 T16084 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 3494012 T16084 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3494014 T16084 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3494016 T16084 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3494017 T16084 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3494018 T16084 oasc.SolrCore.initStatsCache Using default
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 3494022 T16084 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 3494023 T16084 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 3494024 T16084 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=19, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=86.78125,
floorSegmentMB=1.58203125, forceMergeDeletesPctAllowed=7.892557550101045,
segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.8433328114929179
[junit4] 2> 3494025 T16084 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@5cc70656
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e98128a),segFN=segments_1,generation=1}
[junit4] 2> 3494025 T16084 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 3494026 T16084 oass.SolrIndexSearcher.<init> Opening
Searcher@2f07c157[collection1] main
[junit4] 2> 3494026 T16084 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/control_collection
[junit4] 2> 3494030 T16084 oascc.ZkStateReader.readConfigName
path=/collections/control_collection configName=conf1 specified config exists
in ZooKeeper
[junit4] 2> 3494030 T16084 oasr.ManagedResourceStorage.newStorageIO
Setting up ZooKeeper-based storage for the RestManager with znodeBase:
/configs/conf1
[junit4] 2> 3494032 T16084
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 3494032 T16084 oasr.RestManager.init Initializing RestManager
with initArgs: {}
[junit4] 2> 3494033 T16084 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 3494034 T16084
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 3494034 T16084 oasr.ManagedResourceStorage.load Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 3494035 T16084 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 3494035 T16084 oash.ReplicationHandler.inform Commits will be
reserved for 10000
[junit4] 2> 3494036 T16084 oasc.CoreContainer.registerCore registering
core: collection1
[junit4] 2> 3494036 T16085 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@2f07c157[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 3494038 T16088 oasc.ZkController.register Register replica -
core:collection1 address:http://127.0.0.1:52957 collection:control_collection
shard:shard1
[junit4] 2> 3494038 T16052 oass.SolrDispatchFilter.init
user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 3494039 T16052 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 3494040 T16052
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3494041 T16088 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/leader_elect/shard1/election
[junit4] 2> 3494042 T16052 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3494046 T16091 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1113e0ab
name:ZooKeeperConnection Watcher:127.0.0.1:52954/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3494046 T16052 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3494047 T16052 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3494049 T16052
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 3494057 T16088
oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for
shard shard1
[junit4] 2> 3494058 T16052 oasc.ChaosMonkey.monkeyLog monkey: init -
expire sessions:false cause connection loss:false
[junit4] 2> 3494059 T16052 oasc.AbstractFullDistribZkTestBase.createJettys
Creating collection1 with stateFormat=2
[junit4] 2> 3494060 T16052
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3494061 T16052 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3494063 T16080 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 3494064 T16094 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5ef0dd9 name:ZooKeeperConnection
Watcher:127.0.0.1:52954/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 3494064 T16088
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 3494066 T16088
oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try
and sync
[junit4] 2> ASYNC NEW_CORE C2496 name=collection1
org.apache.solr.core.SolrCore@7dc03a11 url=http://127.0.0.1:52957/collection1
node=127.0.0.1:52957_ C2496_STATE=coll:control_collection core:collection1
props:{core=collection1, base_url=http://127.0.0.1:52957,
node_name=127.0.0.1:52957_, state=down}
[junit4] 2> 3494066 T16088 C2496 P52957 oasc.SyncStrategy.sync Sync
replicas to http://127.0.0.1:52957/collection1/
[junit4] 2> 3494066 T16088 C2496 P52957 oasc.SyncStrategy.syncReplicas
Sync Success - now sync replicas to me
[junit4] 2> 3494067 T16088 C2496 P52957 oasc.SyncStrategy.syncToMe
http://127.0.0.1:52957/collection1/ has no replicas
[junit4] 2> 3494067 T16088
oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader:
http://127.0.0.1:52957/collection1/ shard1
[junit4] 2> 3494065 T16052 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3494067 T16088 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/leaders/shard1
[junit4] 2> 3494066 T16081 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> 3494068 T16052 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3494078 T16081 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"create",
[junit4] 2> "name":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "stateFormat":"2"} current state version: 1
[junit4] 2> 3494079 T16081 oasco.ClusterStateMutator.createCollection
building a new cName: collection1
[junit4] 2> 3494086 T16080 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> 3494092 T16081 oasco.ZkStateWriter.writePendingUpdates going
to create_collection /collections/collection1/state.json
[junit4] 2> 3494097 T16091 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> 3494101 T16095 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 3494109 T16080 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 3494113 T16081 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:52957";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 3
[junit4] 2> 3494225 T16091 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> 3494227 T16080 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> 3494266 T16088 oasc.ZkController.register We are
http://127.0.0.1:52957/collection1/ and leader is
http://127.0.0.1:52957/collection1/
[junit4] 2> 3494266 T16088 oasc.ZkController.register No LogReplay needed
for core=collection1 baseURL=http://127.0.0.1:52957
[junit4] 2> 3494267 T16088 oasc.ZkController.checkRecovery I am the
leader, no recovery necessary
[junit4] 2> 3494267 T16088 oasc.ZkController.publish publishing
core=collection1 state=active collection=control_collection
[junit4] 2> 3494267 T16088 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 3494270 T16080 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 3494277 T16081 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:52957";,
[junit4] 2> "node_name":"127.0.0.1:52957_",
[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> 3494279 T16081 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:52957";,
[junit4] 2> "node_name":"127.0.0.1:52957_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 3494388 T16080 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> 3494390 T16091 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> 3495989 T16052 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
6CB9F97D2A824137-001/shard-1-001/cores/collection1
[junit4] 2> 3495994 T16052 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1
[junit4] 2> 3495998 T16052 oejs.Server.doStart jetty-9.2.6.v20141205
[junit4] 2> 3496008 T16052 oejsh.ContextHandler.doStart Started
o.e.j.s.ServletContextHandler@794d5565{/,null,AVAILABLE}
[junit4] 2> 3496013 T16052 oejs.AbstractConnector.doStart Started
ServerConnector@1523725f{HTTP/1.1}{127.0.0.1:52962}
[junit4] 2> 3496013 T16052 oejs.Server.doStart Started @3500391ms
[junit4] 2> 3496015 T16052 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@4554617c
[junit4] 2> 3496017 T16052 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 3496020 T16052 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
6CB9F97D2A824137-001/shard-1-001
[junit4] 2> 3496022 T16052 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
6CB9F97D2A824137-001/shard-1-001/'
[junit4] 2> 3496099 T16052 oasc.ConfigSolr.fromFile Loading container
configuration from
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
6CB9F97D2A824137-001/shard-1-001/solr.xml
[junit4] 2> 3496115 T16052 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
6CB9F97D2A824137-001/shard-1-001/cores
[junit4] 2> 3496117 T16052 oasc.CoreContainer.<init> New CoreContainer
1079907618
[junit4] 2> 3496118 T16052 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
6CB9F97D2A824137-001/shard-1-001/]
[junit4] 2> 3496119 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 3496120 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 3496120 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 3496121 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 3496121 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 3496122 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 3496123 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 3496123 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 3496124 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 3496124 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 3496126 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting useRetries to: false
[junit4] 2> 3496127 T16052 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 3496128 T16052 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3496128 T16052 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3496129 T16052 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3496130 T16052 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:52954/solr
[junit4] 2> 3496130 T16052 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 3496131 T16052
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3496132 T16052 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3496136 T16109 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@497d5447
name:ZooKeeperConnection Watcher:127.0.0.1:52954 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3496136 T16052 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3496137 T16052 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3496144 T16052 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3496147 T16112 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@562ee314
name:ZooKeeperConnection Watcher:127.0.0.1:52954/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3496148 T16052 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3496170 T16052
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 3497192 T16052 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52962_
[junit4] 2> 3497195 T16052 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:52962_
[junit4] 2> 3497209 T16052 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 3497216 T16052 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
6CB9F97D2A824137-001/shard-1-001/cores
[junit4] 2> 3497217 T16052 oasc.CorePropertiesLocator.discoverUnder Found
core collection1 in
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
6CB9F97D2A824137-001/shard-1-001/cores/collection1/
[junit4] 2> 3497218 T16052 oasc.CorePropertiesLocator.discover Found 1
core definitions
[junit4] 2> 3497229 T16113 oasc.ZkController.publish publishing
core=collection1 state=down collection=collection1
[junit4] 2> 3497230 T16113 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 3497234 T16080 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 3497236 T16113 oasc.ZkController.preRegister Registering watch
for external collection collection1
[junit4] 2> 3497236 T16113 oascc.ZkStateReader.addZkWatch addZkWatch
collection1
[junit4] 2> 3497237 T16081 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:52962";,
[junit4] 2> "node_name":"127.0.0.1:52962_",
[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> 3497237 T16113 oascc.ZkStateReader.addZkWatch Updating
collection state at /collections/collection1/state.json from ZooKeeper...
[junit4] 2> 3497238 T16081 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:52962";,
[junit4] 2> "node_name":"127.0.0.1:52962_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"}
[junit4] 2> 3497238 T16081 oasco.ReplicaMutator.updateState Collection
already exists with numShards=2
[junit4] 2> 3497238 T16081 oasco.ReplicaMutator.updateState Assigning new
node to shard shard=shard2
[junit4] 2> 3497241 T16113 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 0
[junit4] 2> 3497241 T16113 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 3497244 T16081 oasco.ZkStateWriter.writePendingUpdates going
to update_collection /collections/collection1/state.json version: 0
[junit4] 2> 3497247 T16112 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 3497248 T16112 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 1
[junit4] 2> 3498243 T16113 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for collection1
[junit4] 2> 3498244 T16113 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:collection1
[junit4] 2> 3498248 T16113 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 3498248 T16113 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 3498252 T16113 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 3498253 T16113 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
6CB9F97D2A824137-001/shard-1-001/cores/collection1/'
[junit4] 2> 3498279 T16113 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 3498285 T16113 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 3498298 T16113 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 3498303 T16113 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 6.0.0
[junit4] 2> 3498316 T16113 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 3498320 T16113 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 3498329 T16113 oass.IndexSchema.readSchema [collection1]
Schema name=test
[junit4] 2> 3498450 T16113 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3498457 T16113 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 3498457 T16113 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3498488 T16113 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3498493 T16113 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3498498 T16113 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3498501 T16113
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3498502 T16113
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3498502 T16113 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3498535 T16113
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3498535 T16113
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3498536 T16113 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection collection1
[junit4] 2> 3498536 T16113 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3498537 T16113 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
6CB9F97D2A824137-001/shard-1-001/cores/collection1/,
dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
6CB9F97D2A824137-001/tempDir-001/jetty1/
[junit4] 2> 3498537 T16113 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7bebc24f
[junit4] 2> 3498538 T16113 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
6CB9F97D2A824137-001/tempDir-001/jetty1
[junit4] 2> 3498539 T16113 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
6CB9F97D2A824137-001/tempDir-001/jetty1/index/
[junit4] 2> 3498539 T16113 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
6CB9F97D2A824137-001/tempDir-001/jetty1/index' doesn't exist. Creating new
index...
[junit4] 2> 3498539 T16113 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
6CB9F97D2A824137-001/tempDir-001/jetty1/index
[junit4] 2> 3498540 T16113 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=27, maxMergeAtOnceExplicit=21, maxMergedSegmentMB=5.3818359375,
floorSegmentMB=0.24609375, forceMergeDeletesPctAllowed=1.0226153800254012,
segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.7018809781004215
[junit4] 2> 3498541 T16113 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@4dd2b413
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@57e1b00),segFN=segments_1,generation=1}
[junit4] 2> 3498541 T16113 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 3498545 T16113 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 3498546 T16113 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 3498546 T16113 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe"
[junit4] 2> 3498547 T16113 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 3498547 T16113 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"stored_sig"
[junit4] 2> 3498547 T16113 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3498548 T16113 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3498548 T16113 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 3498548 T16113 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3498549 T16113 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3498550 T16113 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3498551 T16113 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3498551 T16113 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3498552 T16113 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 3498553 T16113 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 3498554 T16113 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 3498555 T16113 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 3498555 T16113 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 3498558 T16113 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 3498559 T16113 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 3498559 T16113 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 3498560 T16113 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 3498560 T16113 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 3498561 T16113 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 3498561 T16113 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 3498562 T16113 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 3498563 T16113 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 3498570 T16113 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3498571 T16113 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3498572 T16113 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3498573 T16113 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3498574 T16113 oasc.SolrCore.initStatsCache Using default
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 3498576 T16113 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 3498576 T16113 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 3498577 T16113 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=19, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=86.78125,
floorSegmentMB=1.58203125, forceMergeDeletesPctAllowed=7.892557550101045,
segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.8433328114929179
[junit4] 2> 3498578 T16113 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@4dd2b413
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@57e1b00),segFN=segments_1,generation=1}
[junit4] 2> 3498578 T16113 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 3498578 T16113 oass.SolrIndexSearcher.<init> Opening
Searcher@76b5ed4f[collection1] main
[junit4] 2> 3498578 T16113 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 3498581 T16113 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 3498582 T16113 oasr.ManagedResourceStorage.newStorageIO
Setting up ZooKeeper-based storage for the RestManager with znodeBase:
/configs/conf1
[junit4] 2> 3498583 T16113
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 3498583 T16113 oasr.RestManager.init Initializing RestManager
with initArgs: {}
[junit4] 2> 3498583 T16113 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 3498585 T16113
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 3498585 T16113 oasr.ManagedResourceStorage.load Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 3498585 T16113 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 3498586 T16113 oash.ReplicationHandler.inform Commits will be
reserved for 10000
[junit4] 2> 3498587 T16114 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@76b5ed4f[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 3498588 T16113 oasc.CoreContainer.registerCore registering
core: collection1
[junit4] 2> 3498590 T16117 oasc.ZkController.register Register replica -
core:collection1 address:http://127.0.0.1:52962 collection:collection1
shard:shard2
[junit4] 2> 3498591 T16052 oass.SolrDispatchFilter.init
user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 3498591 T16052 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 3498592 T16117 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leader_elect/shard2/election
[junit4] 2> 3498604 T16117
oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for
shard shard2
[junit4] 2> 3498608 T16117
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 3498609 T16117
oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try
and sync
[junit4] 2> ASYNC NEW_CORE C2497 name=collection1
org.apache.solr.core.SolrCore@40659fcd url=http://127.0.0.1:52962/collection1
node=127.0.0.1:52962_ C2497_STATE=coll:collection1 core:collection1
props:{core=collection1, base_url=http://127.0.0.1:52962,
node_name=127.0.0.1:52962_, state=down}
[junit4] 2> 3498609 T16117 C2497 P52962 oasc.SyncStrategy.sync Sync
replicas to http://127.0.0.1:52962/collection1/
[junit4] 2> 3498609 T16117 C2497 P52962 oasc.SyncStrategy.syncReplicas
Sync Success - now sync replicas to me
[junit4] 2> 3498609 T16117 C2497 P52962 oasc.SyncStrategy.syncToMe
http://127.0.0.1:52962/collection1/ has no replicas
[junit4] 2> 3498610 T16117
oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader:
http://127.0.0.1:52962/collection1/ shard2
[junit4] 2> 3498610 T16117 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leaders/shard2
[junit4] 2> 3498621 T16080 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 3498623 T16081 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 2, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"collection1"} current state version: 5
[junit4] 2> 3498626 T16081 oasco.ZkStateWriter.writePendingUpdates going
to update_collection /collections/collection1/state.json version: 1
[junit4] 2> 3498627 T16112 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 3498629 T16112 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 2
[junit4] 2> 3498638 T16081 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:52962";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 5
[junit4] 2> 3498642 T16081 oasco.ZkStateWriter.writePendingUpdates going
to update_collection /collections/collection1/state.json version: 2
[junit4] 2> 3498643 T16112 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 3498647 T16112 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 3
[junit4] 2> 3498651 T16080 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 3498672 T16117 oasc.ZkController.register We are
http://127.0.0.1:52962/collection1/ and leader is
http://127.0.0.1:52962/collection1/
[junit4] 2> 3498673 T16117 oasc.ZkController.register No LogReplay needed
for core=collection1 baseURL=http://127.0.0.1:52962
[junit4] 2> 3498673 T16117 oasc.ZkController.checkRecovery I am the
leader, no recovery necessary
[junit4] 2> 3498673 T16117 oasc.ZkController.publish publishing
core=collection1 state=active collection=collection1
[junit4] 2> 3498673 T16117 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 3498677 T16080 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 3498680 T16081 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:52962";,
[junit4] 2> "node_name":"127.0.0.1:52962_",
[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> 3498682 T16081 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:52962";,
[junit4] 2> "node_name":"127.0.0.1:52962_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"}
[junit4] 2> 3498685 T16081 oasco.ZkStateWriter.writePendingUpdates going
to update_collection /collections/collection1/state.json version: 3
[junit4] 2> 3498687 T16112 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 3498697 T16117 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 4
[junit4] 2> 3498708 T16112 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 4
[junit4] 2> 3500409 T16052 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
6CB9F97D2A824137-001/shard-2-001/cores/collection1
[junit4] 2> 3500412 T16052 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2
[junit4] 2> 3500413 T16052 oejs.Server.doStart jetty-9.2.6.v20141205
[junit4] 2> 3500419 T16052 oejsh.ContextHandler.doStart Started
o.e.j.s.ServletContextHandler@12f8ccc5{/,null,AVAILABLE}
[junit4] 2> 3500420 T16052 oejs.AbstractConnector.doStart Started
ServerConnector@4e2f9c36{HTTP/1.1}{127.0.0.1:52965}
[junit4] 2> 3500421 T16052 oejs.Server.doStart Started @3504799ms
[junit4] 2> 3500421 T16052 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@4554617c
[junit4] 2> 3500422 T16052 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 3500422 T16052 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
6CB9F97D2A824137-001/shard-2-001
[junit4] 2> 3500423 T16052 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
6CB9F97D2A824137-001/shard-2-001/'
[junit4] 2> 3500468 T16052 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
6CB9F97D2A824137-001/shard-2-001/solr.xml
[junit4] 2> 3500480 T16052 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
6CB9F97D2A824137-001/shard-2-001/cores
[junit4] 2> 3500480 T16052 oasc.CoreContainer.<init> New CoreContainer
800549038
[junit4] 2> 3500481 T16052 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
6CB9F97D2A824137-001/shard-2-001/]
[junit4] 2> 3500482 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 3500482 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 3500482 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 3500483 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 3500483 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 3500483 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 3500483 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 3500484 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 3500484 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 3500484 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 3500485 T16052 oashc.HttpShardHandlerFactory.getParameter
Setting useRetries to: false
[junit4] 2> 3500486 T16052 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 3500486 T16052 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3500487 T16052 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3500487 T16052 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3500488 T16052 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:52954/solr
[junit4] 2> 3500488 T16052 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 3500489 T16052
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3500490 T16052 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3500494 T16131 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@529eb1ab
name:ZooKeeperConnection Watcher:127.0.0.1:52954 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3500494 T16052 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3500495 T16052 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3500501 T16052 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3500505 T16134 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@d8ccf0d name:ZooKeeperConnection
Watcher:127.0.0.1:52954/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 3500505 T16052 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3500525 T16052
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 3501544 T16052 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52965_
[junit4] 2> 3501547 T16052 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:52965_
[junit4] 2> 3501560 T16052 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 3501567 T16052 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
6CB9F97D2A824137-001/shard-2-001/cores
[junit4] 2> 3501568 T16052 oasc.CorePropertiesLocator.discoverUnder Found
core collection1 in
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
6CB9F97D2A824137-001/shard-2-001/cores/collection1/
[junit4] 2> 3501569 T16052 oasc.CorePropertiesLocator.discover Found 1
core definitions
[junit4] 2> 3501576 T16135 oasc.ZkController.publish publishing
core=collection1 state=down collection=collection1
[junit4] 2> 3501577 T16135 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 3501581 T16080 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 3501584 T16135 oasc.ZkController.preRegister Registering watch
for external collection collection1
[junit4] 2> 3501584 T16135 oascc.ZkStateReader.addZkWatch addZkWatch
collection1
[junit4] 2> 3501584 T16081 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:52965";,
[junit4] 2> "node_name":"127.0.0.1:52965_",
[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> 3501585 T16135 oascc.ZkStateReader.addZkWatch Updating
collection state at /collections/collection1/state.json from ZooKeeper...
[junit4] 2> 3501586 T16081 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:52965";,
[junit4] 2> "node_name":"127.0.0.1:52965_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"}
[junit4] 2> 3501587 T16081 oasco.ReplicaMutator.updateState Collection
already exists with numShards=2
[junit4] 2> 3501587 T16081 oasco.ReplicaMutator.updateState Assigning new
node to shard shard=shard1
[junit4] 2> 3501588 T16135 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 4
[junit4] 2> 3501588 T16135 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 3501590 T16081 oasco.ZkStateWriter.writePendingUpdates going
to update_collection /collections/collection1/state.json version: 4
[junit4] 2> 3501592 T16112 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 3501592 T16134 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 3501594 T16134 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 5
[junit4] 2> 3501594 T16112 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 5
[junit4] 2> 3502592 T16135 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for collection1
[junit4] 2> 3502592 T16135 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:collection1
[junit4] 2> 3502595 T16135 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 3502596 T16135 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 3502600 T16135 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 3502600 T16135 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
6CB9F97D2A824137-001/shard-2-001/cores/collection1/'
[junit4] 2> 3502629 T16135 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 3502634 T16135 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 3502646 T16135 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 3502652 T16135 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 6.0.0
[junit4] 2> 3502666 T16135 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 3502671 T16135 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 3502677 T16135 oass.IndexSchema.readSchema [collection1]
Schema name=test
[junit4] 2> 3502795 T16135 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3502805 T16135 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 3502806 T16135 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3502839 T16135 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3502845 T16135 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3502849 T16135 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3502853 T16135
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3502854 T16135
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3502854 T16135 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3502857 T16135
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3502857 T16135
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3502857 T16135 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection collection1
[junit4] 2> 3502858 T16135 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3502858 T16135 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
6CB9F97D2A824137-001/shard-2-001/cores/collection1/,
dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
6CB9F97D2A824137-001/tempDir-001/jetty2/
[junit4] 2> 3502859 T16135 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7bebc24f
[junit4] 2> 3502860 T16135 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
6CB9F97D2A824137-001/tempDir-001/jetty2
[junit4] 2> 3502860 T16135 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
6CB9F97D2A824137-001/tempDir-001/jetty2/index/
[junit4] 2> 3502861 T16135 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
6CB9F97D2A824137-001/tempDir-001/jetty2/index' doesn't exist. Creating new
index...
[junit4] 2> 3502861 T16135 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.DeleteReplicaTest
6CB9F97D2A824137-001/tempDir-001/jetty2/index
[junit4] 2> 3502862 T16135 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=27, maxMergeAtOnceExplicit=21, maxMergedSegmentMB=5.3818359375,
floorSegmentMB=0.24609375, forceMergeDeletesPctAllowed=1.0226153800254012,
segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.7018809781004215
[junit4] 2> 3502863 T16135 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@ddb6733
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3b3e7f61),segFN=segments_1,generation=1}
[junit4] 2> 3502863 T16135 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 3502868 T16135 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 3502868 T16135 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 3502869 T16135 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe"
[junit4] 2> 3502869 T16135 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 3502869 T16135 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"stored_sig"
[junit4] 2> 3502870 T16135 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3502871 T16135 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3502871 T16135 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 3502871 T16135 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3502873 T16135 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3502873 T16135 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3502874 T16135 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3502874 T16135 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3502876 T16135 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 3502877 T16135 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 3502878 T16135 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 3502878 T16135 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 3502879 T16135 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 3502881 T16135 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 3502882 T16135 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 3502882 T16135 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 3502883 T16135 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 3502884 T16135 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 3502885 T16135 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 3502886 T16135 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 3502886 T16135 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 3502887 T16135 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 3502897 T16135 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3502899 T16135 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3502902 T16135 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3502903 T16135 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3502904 T16135 oasc.SolrCore.initStatsCache Using default
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 3502907 T16135 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 3502908 T16135 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 3502908 T16135 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=19, maxM
[...truncated too long message...]
S X 10.8.5 x86_64/Oracle Corporation 1.8.0_31
(64-bit)/cpus=2,threads=1,free=101616560,total=499122176
[junit4] 2> NOTE: All tests run in this JVM: [ExternalFileFieldSortTest,
BlockCacheTest, HttpPartitionTest, CurrencyFieldOpenExchangeTest,
CSVRequestHandlerTest, UUIDFieldTest, TestLRUCache, SpatialHeatmapFacetsTest,
SimpleMLTQParserTest, TestManagedResource, DebugComponentTest,
ChangedSchemaMergeTest, DOMUtilTest, TestFaceting, TestPostingsSolrHighlighter,
SolrIndexSplitterTest, MultiTermTest, DateMathParserTest,
HdfsUnloadDistributedZkTest, UUIDUpdateProcessorFallbackTest, RecoveryZkTest,
TestPartialUpdateDeduplication, TestSolrXml, TestInitQParser,
TestFoldingMultitermQuery, TestFuzzyAnalyzedSuggestions, TestXIncludeConfig,
SolrCmdDistributorTest, AlternateDirectoryTest, URLClassifyProcessorTest,
TestAnalyzeInfixSuggestions, AssignTest, TestFieldTypeCollectionResource,
TestOrdValues, TestCloudInspectUtil, TestTolerantSearch, TestStressReorder,
SchemaVersionSpecificBehaviorTest, CachingDirectoryFactoryTest,
ShardRoutingTest, HdfsDirectoryTest, TestJmxIntegration,
TestSortingResponseWriter, TestWriterPerf, TestFastOutputStream,
TestManagedSchemaFieldTypeResource, ZkControllerTest, TestRestManager,
TestCollationField, ConvertedLegacyTest, TestSchemaNameResource,
NotRequiredUniqueKeyTest, TestQueryUtils, CoreAdminRequestStatusTest,
DistributedTermsComponentTest, DirectSolrSpellCheckerTest, OverseerTest,
TestSolrJ, ShardSplitTest, UpdateParamsTest, FileBasedSpellCheckerTest,
ShardRoutingCustomTest, PrimitiveFieldTypeTest, ExternalCollectionsTest,
TestAddFieldRealTimeGet, DirectSolrConnectionTest, TestFiltering,
TestAnalyzedSuggestions, DocValuesTest, CustomCollectionTest,
DateRangeFieldTest, DistanceUnitsTest, HdfsChaosMonkeySafeLeaderTest,
QueryParsingTest, RemoteQueryErrorTest, DistributedFacetPivotLargeTest,
MultiThreadedOCPTest, TestDefaultSearchFieldResource, JSONWriterTest,
TestExpandComponent, TestStressVersions, QueryResultKeyTest, TestRangeQuery,
DistributedFacetPivotSmallAdvancedTest, TestExactSharedStatsCache, TestUtils,
TestFunctionQuery, InfoHandlerTest, PolyFieldTest, SliceStateTest,
SuggesterTSTTest, TestDocumentBuilder, BadComponentTest,
RAMDirectoryFactoryTest, AtomicUpdatesTest, AnalysisErrorHandlingTest,
TestBlobHandler, TestDistributedSearch, TestWordDelimiterFilterFactory,
ZkNodePropsTest, TestSchemaManager, HdfsLockFactoryTest,
TestDFRSimilarityFactory, TestNoOpRegenerator, DistributedExpandComponentTest,
DistributedFacetPivotLongTailTest, TestDefaultStatsCache,
RegexBoostProcessorTest, DocExpirationUpdateProcessorFactoryTest,
AddSchemaFieldsUpdateProcessorFactoryTest, TestFreeTextSuggestions,
TestBulkSchemaConcurrent, AsyncMigrateRouteKeyTest, SearchHandlerTest,
SoftAutoCommitTest, TestSolrCoreProperties,
DistributedQueryComponentOptimizationTest, TestCharFilters,
HighlighterConfigTest, TestIntervalFaceting, TestSolr4Spatial2,
SpatialRPTFieldTypeTest, RankQueryTest, TestPseudoReturnFields,
TestLeaderElectionZkExpiry, TestSerializedLuceneMatchVersion,
TestManagedStopFilterFactory, TestExactStatsCache, TestSolrConfigHandlerCloud,
HardAutoCommitTest, DistribDocExpirationUpdateProcessorTest,
TestRandomFaceting, TestRawResponseWriter, CurrencyFieldXmlFileTest,
SolrCoreTest, HdfsWriteToMultipleCollectionsTest, RequestLoggingTest,
ParsingFieldUpdateProcessorsTest, MinimalSchemaTest, TestReRankQParserPlugin,
LeaderElectionTest, TestCursorMarkWithoutUniqueKey, AddBlockUpdateTest,
CoreAdminHandlerTest, TimeZoneUtilsTest, TestBinaryResponseWriter,
BasicFunctionalityTest, MoreLikeThisHandlerTest, BasicDistributedZk2Test,
SolrCoreCheckLockOnStartupTest, TestManagedSynonymFilterFactory,
TestCustomSort, SuggesterWFSTTest, TestClusterStateMutator, DeleteShardTest,
CoreAdminCreateDiscoverTest, RequiredFieldsTest, AnalyticsQueryTest,
TestDocSet, TestChildDocTransformer, DistributedSpellCheckComponentTest,
SOLR749Test, TestPivotHelperCode, TestFileDictionaryLookup, TestIndexSearcher,
OpenExchangeRatesOrgProviderTest, TestCoreDiscovery, FastVectorHighlighterTest,
TestBulkSchemaAPI, DocValuesMultiTest, TestConfig, SortByFunctionTest,
DistributedQueueTest, DefaultValueUpdateProcessorTest, TestReload,
TestReplicationHandler, TestCollationFieldDocValues,
TriLevelCompositeIdRoutingTest, DistributedFacetPivotWhiteBoxTest,
TestQueryTypes, IndexSchemaTest, TestMaxScoreQueryParser,
CoreMergeIndexesAdminHandlerTest, SimpleCollectionCreateDeleteTest,
TestConfigSets, CloudMLTQParserTest, SampleTest, ConnectionManagerTest,
TestManagedResourceStorage, TestQuerySenderListener, LukeRequestHandlerTest,
SuggesterFSTTest, DirectUpdateHandlerOptimizeTest,
TestManagedSchemaDynamicFieldResource, SpellingQueryConverterTest,
AliasIntegrationTest, TestRecoveryHdfs, WordBreakSolrSpellCheckerTest,
TestSchemaVersionResource, TestSolrConfigHandler, TestSimpleQParserPlugin,
SolrInfoMBeanTest, TestBinaryField, ZkStateWriterTest,
ResponseLogComponentTest, TestUpdate, TestIBSimilarityFactory,
SaslZkACLProviderTest, TestNonDefinedSimilarityFactory, AutoCommitTest,
TestReloadAndDeleteDocs, TermVectorComponentDistributedTest,
TestManagedSchemaFieldResource, TestOmitPositions, TestStressUserVersions,
DistributedQueryComponentCustomSortTest, SpellCheckCollatorTest,
OutOfBoxZkACLAndCredentialsProvidersTest, TestComplexPhraseQParserPlugin,
RecoveryAfterSoftCommitTest, ClusterStateTest, BasicDistributedZkTest,
ChaosMonkeySafeLeaderTest, UnloadDistributedZkTest,
CollectionsAPIDistributedZkTest, SyncSliceTest, OpenCloseCoreStressTest,
LeaderElectionIntegrationTest, BasicZkTest, FullSolrCloudDistribCmdsTest,
ClusterStateUpdateTest, ZkSolrClientTest, TestZkChroot, TestRandomDVFaceting,
ZkCLITest, TestDistributedGrouping, TestRecovery, TestHashPartitioner,
TestRealTimeGet, TestJoin, TestCoreContainer, SimpleFacetsTest,
TestSolr4Spatial, StatsComponentTest, SpellCheckComponentTest,
TestGroupingSearch, QueryElevationComponentTest, PeerSyncTest,
BadIndexSchemaTest, TestSort, TestLazyCores, DirectUpdateHandlerTest,
TestBadConfig, OverseerCollectionProcessorTest, HighlighterTest,
ShowFileRequestHandlerTest, DistributedQueryElevationComponentTest,
SimplePostToolTest, AnalysisAfterCoreReloadTest,
SignatureUpdateProcessorFactoryTest, TestExtendedDismaxParser,
SolrRequestParserTest, SuggesterTest, TestStressLucene, TestTrie,
SpatialFilterTest, TestCSVLoader, NoCacheHeaderTest,
FieldMutatingUpdateProcessorTest, TestAtomicUpdateErrorCases,
QueryEqualityTest, StatelessScriptUpdateProcessorFactoryTest,
TestRemoteStreaming, DistanceFunctionTest, TestSolrDeletionPolicy1,
XsltUpdateRequestHandlerTest, CacheHeaderTest, IndexBasedSpellCheckerTest,
TestSurroundQueryParser, DisMaxRequestHandlerTest, StandardRequestHandlerTest,
TestReversedWildcardFilterFactory, DocumentAnalysisRequestHandlerTest,
TermsComponentTest, XmlUpdateRequestHandlerTest, RequestHandlersTest,
DocumentBuilderTest, TestValueSourceCache, PathHierarchyTokenizerFactoryTest,
TermVectorComponentTest, TestIndexingPerformance,
FieldAnalysisRequestHandlerTest, TestSolrQueryParser, TestArbitraryIndexDir,
IndexSchemaRuntimeFieldTest, LoggingHandlerTest, SolrPluginUtilsTest,
ReturnFieldsTest, UpdateRequestProcessorFactoryTest, TestCSVResponseWriter,
MBeansHandlerTest, UniqFieldsUpdateProcessorFactoryTest, JsonLoaderTest,
BinaryUpdateRequestHandlerTest, TestPHPSerializedResponseWriter,
PingRequestHandlerTest, TestComponentsName, TestLFUCache, TestSolrIndexConfig,
TestQuerySenderNoQuery, CopyFieldTest, SolrIndexConfigTest, TestStressRecovery,
TestMergePolicyConfig, TestSolrDeletionPolicy2, TestSearchPerf,
NumericFieldsTest, TestElisionMultitermQuery, OutputWriterTest,
TestLuceneMatchVersion, TestPhraseSuggestions, SpellPossibilityIteratorTest,
TestCodecSupport, SynonymTokenizerTest, EchoParamsTest,
TestSweetSpotSimilarityFactory, TestPerFieldSimilarity,
TestLMDirichletSimilarityFactory, TestLMJelinekMercerSimilarityFactory,
TestBM25SimilarityFactory, TestDefaultSimilarityFactory, TestFastWriter,
TestJmxMonitoredMap, ResourceLoaderTest, ScriptEngineTest, PluginInfoTest,
TestFastLRUCache, ChaosMonkeyNothingIsSafeTest, PreAnalyzedFieldTest,
TestSystemIdResolver, PrimUtilsTest, TestSuggestSpellingConverter,
DateFieldTest, SystemInfoHandlerTest, FileUtilsTest, CircularListTest,
DistributedMLTComponentTest, TestRTGBase, CursorPagingTest,
DistributedIntervalFacetingTest, SolrTestCaseJ4Test,
TestDistributedMissingSort, TestHighlightDedupGrouping, ActionThrottleTest,
CloudExitableDirectoryReaderTest, CollectionsAPIAsyncDistributedZkTest,
DeleteInactiveReplicaTest, DeleteReplicaTest]
[junit4] Completed in 36.39s, 1 test, 1 failure <<< FAILURES!
[...truncated 308 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:509:
The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:1349:
The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:957:
There were test failures: 466 suites, 1861 tests, 1 failure, 51 ignored (20
assumptions)
Total time: 125 minutes 46 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.8.0
-XX:+UseCompressedOops -XX:+UseG1GC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org
