Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-MacOSX/1881/
Java: 64bit/jdk1.7.0 -XX:+UseCompressedOops -XX:+UseG1GC
1 tests failed.
FAILED: org.apache.solr.handler.TestSolrConfigHandlerCloud.testDistribSearch
Error Message:
Could not get expected value A val for path [params, a] full output null
Stack Trace:
java.lang.AssertionError: Could not get expected value A val for path [params,
a] full output null
at
__randomizedtesting.SeedInfo.seed([3B7851A6C8283EE0:BA9EDFBEBF775EDC]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.core.TestSolrConfigHandler.testForResponseElement(TestSolrConfigHandler.java:259)
at
org.apache.solr.handler.TestSolrConfigHandlerCloud.testReqParams(TestSolrConfigHandlerCloud.java:137)
at
org.apache.solr.handler.TestSolrConfigHandlerCloud.doTest(TestSolrConfigHandlerCloud.java:70)
at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:868)
at sun.reflect.GeneratedMethodAccessor79.invoke(Unknown Source)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
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
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 10281 lines...]
[junit4] Suite: org.apache.solr.handler.TestSolrConfigHandlerCloud
[junit4] 2> Creating dataDir:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/init-core-data-001
[junit4] 2> 5864208 T18792 oas.SolrTestCaseJ4.buildSSLConfig Randomized
ssl (false) and clientAuth (false)
[junit4] 2> 5864208 T18792
oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system
property: /b_z/
[junit4] 2> 5864216 T18792 oas.SolrTestCaseJ4.setUp ###Starting
testDistribSearch
[junit4] 2> 5864217 T18792 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 5864218 T18793 oasc.ZkTestServer$ZKServerMain.runFromConfig
Starting server
[junit4] 2> 5864319 T18792 oasc.ZkTestServer.run start zk server on
port:61115
[junit4] 2> 5864320 T18792
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 5864324 T18792 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5864336 T18800 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@75ed6e25
name:ZooKeeperConnection Watcher:127.0.0.1:61115 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5864337 T18792 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5864338 T18792 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 5864338 T18792 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 5864352 T18792
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 5864355 T18792 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5864360 T18803 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@589bd81a
name:ZooKeeperConnection Watcher:127.0.0.1:61115/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5864361 T18792 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5864361 T18792 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 5864362 T18792 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 5864371 T18792 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 5864381 T18792 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 5864389 T18792 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 5864398 T18792 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 5864399 T18792 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 5864413 T18792 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 5864414 T18792 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 5864421 T18792 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 5864422 T18792 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 5864431 T18792 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 5864431 T18792 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 5864444 T18792 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 5864445 T18792 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 5864457 T18792 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 5864461 T18792 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 5864476 T18792 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 5864477 T18792 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 5864490 T18792 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 5864491 T18792 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 5864500 T18792 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 5864501 T18792 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 5864512 T18792 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 5864512 T18792 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 5864522 T18792 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 5864522 T18792 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> 5866448 T18792 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 5866459 T18792 oejs.AbstractConnector.doStart Started
[email protected]:61118
[junit4] 2> 5866465 T18792 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@6951a712
[junit4] 2> 5866465 T18792 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 5866466 T18792 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-002
[junit4] 2> 5866466 T18792 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-002/'
[junit4] 2> 5866555 T18792 oasc.ConfigSolr.fromFile Loading container
configuration from
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-002/solr.xml
[junit4] 2> 5866655 T18792 oasc.CoreContainer.<init> New CoreContainer
1456511844
[junit4] 2> 5866655 T18792 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-002/]
[junit4] 2> 5866658 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 5866658 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 5866658 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 5866659 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 5866659 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 5866659 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 5866660 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 5866661 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 5866662 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 5866662 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 5866662 T18792 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 5866663 T18792 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 5866663 T18792 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 5866664 T18792 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 5866665 T18792 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:61115/solr
[junit4] 2> 5866665 T18792 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 5866666 T18792
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 5866667 T18792 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5866672 T18815 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@802d236 name:ZooKeeperConnection
Watcher:127.0.0.1:61115 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 5866673 T18792 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5866673 T18792 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 5866679 T18792 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5866685 T18818 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5498ead2
name:ZooKeeperConnection Watcher:127.0.0.1:61115/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5866686 T18792 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5866691 T18792 oascc.SolrZkClient.makePath makePath:
/overseer/queue
[junit4] 2> 5866705 T18792 oascc.SolrZkClient.makePath makePath:
/overseer/collection-queue-work
[junit4] 2> 5866716 T18792 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-running
[junit4] 2> 5866729 T18792 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-completed
[junit4] 2> 5866742 T18792 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-failure
[junit4] 2> 5866756 T18792 oascc.SolrZkClient.makePath makePath:
/live_nodes
[junit4] 2> 5866762 T18792 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:61118_b_z
[junit4] 2> 5866765 T18792 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:61118_b_z
[junit4] 2> 5866777 T18792 oascc.SolrZkClient.makePath makePath:
/overseer_elect
[junit4] 2> 5866785 T18792 oascc.SolrZkClient.makePath makePath:
/overseer_elect/election
[junit4] 2> 5866795 T18792 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 5866804 T18792 oasc.OverseerElectionContext.runLeaderProcess I
am going to be the leader 127.0.0.1:61118_b_z
[junit4] 2> 5866805 T18792 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 5866814 T18792 oasc.Overseer.start Overseer
(id=93134784853835779-127.0.0.1:61118_b_z-n_0000000000) starting
[junit4] 2> 5866822 T18792 oascc.SolrZkClient.makePath makePath:
/overseer/queue-work
[junit4] 2> 5866860 T18792 oasc.OverseerAutoReplicaFailoverThread.<init>
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 5866862 T18820 oasc.OverseerCollectionProcessor.run Process
current queue of collection creations
[junit4] 2> 5866866 T18792 oascc.SolrZkClient.makePath makePath:
/clusterstate.json
[junit4] 2> 5866876 T18792 oascc.SolrZkClient.makePath makePath:
/aliases.json
[junit4] 2> 5866887 T18792
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 5866903 T18819 oasc.Overseer$ClusterStateUpdater.run Starting
to work on the main queue
[junit4] 2> 5866919 T18822 oasc.ZkController.publish publishing
core=collection1 state=down collection=control_collection
[junit4] 2> 5866920 T18822 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 5866924 T18822 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 5866926 T18818 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5866940 T18819 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 0, message = {
[junit4] 2> "numShards":"1",
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1:61118/b_z";,
[junit4] 2> "shard":null,
[junit4] 2> "roles":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "node_name":"127.0.0.1:61118_b_z",
[junit4] 2> "state":"down",
[junit4] 2> "core":"collection1"} current state version: 0
[junit4] 2> 5866943 T18819 oasco.ReplicaMutator.updateState Update state
numShards=1 message={
[junit4] 2> "numShards":"1",
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1:61118/b_z";,
[junit4] 2> "shard":null,
[junit4] 2> "roles":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "node_name":"127.0.0.1:61118_b_z",
[junit4] 2> "state":"down",
[junit4] 2> "core":"collection1"}
[junit4] 2> 5866944 T18819 oasco.ClusterStateMutator.createCollection
building a new cName: control_collection
[junit4] 2> 5866945 T18819 oasco.ReplicaMutator.updateState Assigning new
node to shard shard=shard1
[junit4] 2> 5866950 T18818 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> 5867927 T18822 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for collection1
[junit4] 2> 5867927 T18822 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:control_collection
[junit4] 2> 5867929 T18822 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 5867930 T18822 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/control_collection
[junit4] 2> 5867934 T18822 oascc.ZkStateReader.readConfigName
path=/collections/control_collection configName=conf1 specified config exists
in ZooKeeper
[junit4] 2> 5867934 T18822 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-002/collection1/'
[junit4] 2> 5867937 T18822 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud%203B7851A6C8283EE0-001/tempDir-002/collection1/lib/.svn/'
to classloader
[junit4] 2> 5867938 T18822 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud%203B7851A6C8283EE0-001/tempDir-002/collection1/lib/classes/'
to classloader
[junit4] 2> 5867939 T18822 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud%203B7851A6C8283EE0-001/tempDir-002/collection1/lib/README'
to classloader
[junit4] 2> 5867988 T18822 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 5867995 T18822 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 5868013 T18822 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 5868046 T18822 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 5868117 T18822 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 5868121 T18822 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 5868135 T18822 oass.IndexSchema.readSchema [collection1]
Schema name=test
[junit4] 2> 5868832 T18822 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 5868850 T18822 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 5868854 T18822 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 5868906 T18822 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 5868914 T18822 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 5868926 T18822 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 5868932 T18822
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 5868932 T18822
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 5868933 T18822 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 5868937 T18822
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 5868937 T18822
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 5868938 T18822 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection control_collection
[junit4] 2> 5868938 T18822 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 5868939 T18822 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-002/collection1/,
dataDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-001/control/data/
[junit4] 2> 5868939 T18822 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@277897fb
[junit4] 2> 5868940 T18822 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-001/control/data
[junit4] 2> 5868940 T18822 oasc.SolrCore.getNewIndexDir New index
directory detected: old=null
new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-001/control/data/index/
[junit4] 2> 5868941 T18822 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-001/control/data/index' doesn't exist. Creating
new index...
[junit4] 2> 5868942 T18822 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-001/control/data/index
[junit4] 2> 5868942 T18822 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=10, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=99.328125,
floorSegmentMB=1.21484375, forceMergeDeletesPctAllowed=0.0657994511244564,
segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.7934733084749283
[junit4] 2> 5868944 T18822 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@77a82cb0
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@420e142f),segFN=segments_1,generation=1}
[junit4] 2> 5868944 T18822 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 5868954 T18822 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 5868955 T18822 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 5868956 T18822 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe"
[junit4] 2> 5868957 T18822 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 5868957 T18822 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"stored_sig"
[junit4] 2> 5868958 T18822 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 5868959 T18822 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 5868959 T18822 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 5868960 T18822 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 5868961 T18822 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5868962 T18822 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5868962 T18822 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5868963 T18822 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5868964 T18822 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 5868966 T18822 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 5868967 T18822 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 5868969 T18822 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 5868970 T18822 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 5868972 T18822 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 5868974 T18822 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 5868975 T18822 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 5868976 T18822 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 5868978 T18822 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 5868980 T18822 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 5868982 T18822 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 5868984 T18822 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 5868985 T18822 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 5869008 T18822 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5869011 T18822 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5869015 T18822 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5869020 T18822 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5869024 T18822 oasc.SolrCore.initStatsCache Using default
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 5869029 T18822 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 5869030 T18822 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 5869032 T18822 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=287265862,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 5869034 T18822 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@77a82cb0
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@420e142f),segFN=segments_1,generation=1}
[junit4] 2> 5869035 T18822 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 5869036 T18822 oass.SolrIndexSearcher.<init> Opening
Searcher@710b146f[collection1] main
[junit4] 2> 5869037 T18822 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/control_collection
[junit4] 2> 5869042 T18822 oascc.ZkStateReader.readConfigName
path=/collections/control_collection configName=conf1 specified config exists
in ZooKeeper
[junit4] 2> 5869042 T18822 oasr.ManagedResourceStorage.newStorageIO
Setting up ZooKeeper-based storage for the RestManager with znodeBase:
/configs/conf1
[junit4] 2> 5869046 T18822
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 5869047 T18822 oasr.RestManager.init Initializing RestManager
with initArgs: {}
[junit4] 2> 5869047 T18822 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 5869051 T18822
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 5869052 T18822 oasr.ManagedResourceStorage.load Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 5869052 T18822 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 5869052 T18822 oash.ReplicationHandler.inform Commits will be
reserved for 10000
[junit4] 2> 5869053 T18822 oasc.CoreContainer.registerCore registering
core: collection1
[junit4] 2> 5869054 T18823 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@710b146f[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 5869056 T18826 oasc.ZkController.register Register replica -
core:collection1 address:http://127.0.0.1:61118/b_z
collection:control_collection shard:shard1
[junit4] 2> 5869057 T18792 oass.SolrDispatchFilter.init
user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 5869058 T18792 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 5869060 T18826 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/leader_elect/shard1/election
[junit4] 2> 5869060 T18792
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 5869065 T18792 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5869070 T18829 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@b6d12af name:ZooKeeperConnection
Watcher:127.0.0.1:61115/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 5869071 T18792 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5869072 T18792 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 5869075 T18792
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 5869080 T18826
oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for
shard shard1
[junit4] 2> 5869088 T18792 oasc.ChaosMonkey.monkeyLog monkey: init -
expire sessions:false cause connection loss:false
[junit4] 2> 5869088 T18818 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5869090 T18826
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 5869090 T18826
oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try
and sync
[junit4] 2> ASYNC NEW_CORE C4324 name=collection1
org.apache.solr.core.SolrCore@533ec740
url=http://127.0.0.1:61118/b_z/collection1 node=127.0.0.1:61118_b_z
C4324_STATE=coll:control_collection core:collection1
props:{base_url=http://127.0.0.1:61118/b_z, node_name=127.0.0.1:61118_b_z,
state=down, core=collection1}
[junit4] 2> 5869090 T18826 C4324 P61118 oasc.SyncStrategy.sync Sync
replicas to http://127.0.0.1:61118/b_z/collection1/
[junit4] 2> 5869091 T18826 C4324 P61118 oasc.SyncStrategy.syncReplicas
Sync Success - now sync replicas to me
[junit4] 2> 5869092 T18826 C4324 P61118 oasc.SyncStrategy.syncToMe
http://127.0.0.1:61118/b_z/collection1/ has no replicas
[junit4] 2> 5869092 T18826
oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader:
http://127.0.0.1:61118/b_z/collection1/ shard1
[junit4] 2> 5869093 T18826 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/leaders/shard1
[junit4] 2> 5869116 T18819 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> 5869121 T18818 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> 5869132 T18819 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:61118/b_z";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 2
[junit4] 2> 5869135 T18829 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> 5869148 T18830 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5869258 T18829 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> 5869321 T18826 oasc.ZkController.register We are
http://127.0.0.1:61118/b_z/collection1/ and leader is
http://127.0.0.1:61118/b_z/collection1/
[junit4] 2> 5869321 T18826 oasc.ZkController.register No LogReplay needed
for core=collection1 baseURL=http://127.0.0.1:61118/b_z
[junit4] 2> 5869321 T18826 oasc.ZkController.checkRecovery I am the
leader, no recovery necessary
[junit4] 2> 5869322 T18826 oasc.ZkController.publish publishing
core=collection1 state=active collection=control_collection
[junit4] 2> 5869322 T18826 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 5869326 T18818 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5869337 T18819 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "numShards":"2",
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1:61118/b_z";,
[junit4] 2> "shard":"shard1",
[junit4] 2> "roles":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "node_name":"127.0.0.1:61118_b_z",
[junit4] 2> "state":"active",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "core":"collection1"} current state version: 3
[junit4] 2> 5869339 T18819 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "numShards":"2",
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1:61118/b_z";,
[junit4] 2> "shard":"shard1",
[junit4] 2> "roles":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "node_name":"127.0.0.1:61118_b_z",
[junit4] 2> "state":"active",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "core":"collection1"}
[junit4] 2> 5869453 T18818 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> 5869453 T18829 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> 5871599 T18792 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1
[junit4] 2> 5871601 T18792 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 5871607 T18792 oejs.AbstractConnector.doStart Started
[email protected]:61122
[junit4] 2> 5871613 T18792 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@6951a712
[junit4] 2> 5871614 T18792 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 5871615 T18792 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-003
[junit4] 2> 5871616 T18792 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-003/'
[junit4] 2> 5871681 T18792 oasc.ConfigSolr.fromFile Loading container
configuration from
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-003/solr.xml
[junit4] 2> 5871784 T18792 oasc.CoreContainer.<init> New CoreContainer
1639284665
[junit4] 2> 5871784 T18792 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-003/]
[junit4] 2> 5871787 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 5871788 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 5871788 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 5871789 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 5871789 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 5871789 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 5871790 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 5871791 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 5871791 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 5871791 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 5871792 T18792 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 5871793 T18792 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 5871794 T18792 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 5871795 T18792 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 5871795 T18792 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:61115/solr
[junit4] 2> 5871795 T18792 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 5871796 T18792
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 5871798 T18792 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5871807 T18842 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@4ff8686a
name:ZooKeeperConnection Watcher:127.0.0.1:61115 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5871808 T18792 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5871809 T18792 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 5871817 T18792 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5871822 T18845 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@48266a82
name:ZooKeeperConnection Watcher:127.0.0.1:61115/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5871823 T18792 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5871845 T18792
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 5872862 T18792 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:61122_b_z
[junit4] 2> 5872866 T18792 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:61122_b_z
[junit4] 2> 5872884 T18792 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 5872904 T18846 oasc.ZkController.publish publishing
core=collection1 state=down collection=collection1
[junit4] 2> 5872905 T18846 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 5872909 T18818 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5872909 T18846 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 5872913 T18819 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "numShards":"2",
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1:61122/b_z";,
[junit4] 2> "shard":null,
[junit4] 2> "roles":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "node_name":"127.0.0.1:61122_b_z",
[junit4] 2> "state":"down",
[junit4] 2> "core":"collection1"} current state version: 4
[junit4] 2> 5872915 T18819 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "numShards":"2",
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1:61122/b_z";,
[junit4] 2> "shard":null,
[junit4] 2> "roles":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "node_name":"127.0.0.1:61122_b_z",
[junit4] 2> "state":"down",
[junit4] 2> "core":"collection1"}
[junit4] 2> 5872915 T18819 oasco.ClusterStateMutator.createCollection
building a new cName: collection1
[junit4] 2> 5872915 T18819 oasco.ReplicaMutator.updateState Assigning new
node to shard shard=shard2
[junit4] 2> 5872920 T18845 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 5872921 T18818 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 5872923 T18829 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 5873912 T18846 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for collection1
[junit4] 2> 5873914 T18846 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:collection1
[junit4] 2> 5873918 T18846 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 5873918 T18846 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 5873922 T18846 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 5873923 T18846 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-003/collection1/'
[junit4] 2> 5873926 T18846 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud%203B7851A6C8283EE0-001/tempDir-003/collection1/lib/.svn/'
to classloader
[junit4] 2> 5873927 T18846 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud%203B7851A6C8283EE0-001/tempDir-003/collection1/lib/classes/'
to classloader
[junit4] 2> 5873929 T18846 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud%203B7851A6C8283EE0-001/tempDir-003/collection1/lib/README'
to classloader
[junit4] 2> 5873969 T18846 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 5873976 T18846 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 5873992 T18846 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 5874028 T18846 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 5874089 T18846 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 5874093 T18846 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 5874104 T18846 oass.IndexSchema.readSchema [collection1]
Schema name=test
[junit4] 2> 5874878 T18846 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 5874902 T18846 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 5874910 T18846 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 5874958 T18846 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 5874967 T18846 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 5874975 T18846 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 5874980 T18846
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 5874981 T18846
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 5874982 T18846 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 5874985 T18846
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 5874986 T18846
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 5874986 T18846 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection collection1
[junit4] 2> 5874987 T18846 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 5874987 T18846 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-003/collection1/,
dataDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-001/jetty1/
[junit4] 2> 5874988 T18846 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@277897fb
[junit4] 2> 5874989 T18846 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-001/jetty1
[junit4] 2> 5874989 T18846 oasc.SolrCore.getNewIndexDir New index
directory detected: old=null
new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-001/jetty1/index/
[junit4] 2> 5874990 T18846 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-001/jetty1/index' doesn't exist. Creating new
index...
[junit4] 2> 5874991 T18846 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-001/jetty1/index
[junit4] 2> 5874991 T18846 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=10, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=99.328125,
floorSegmentMB=1.21484375, forceMergeDeletesPctAllowed=0.0657994511244564,
segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.7934733084749283
[junit4] 2> 5874992 T18846 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@26fa1ae5
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6dfbc460),segFN=segments_1,generation=1}
[junit4] 2> 5874993 T18846 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 5875000 T18846 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 5875002 T18846 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 5875003 T18846 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe"
[junit4] 2> 5875003 T18846 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 5875003 T18846 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"stored_sig"
[junit4] 2> 5875004 T18846 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 5875005 T18846 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 5875006 T18846 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 5875006 T18846 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 5875007 T18846 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5875008 T18846 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5875008 T18846 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5875010 T18846 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5875010 T18846 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 5875011 T18846 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 5875012 T18846 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 5875014 T18846 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 5875015 T18846 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 5875018 T18846 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 5875019 T18846 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 5875019 T18846 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 5875020 T18846 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 5875021 T18846 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 5875022 T18846 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 5875023 T18846 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 5875024 T18846 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 5875024 T18846 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 5875045 T18846 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5875047 T18846 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5875049 T18846 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5875052 T18846 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5875055 T18846 oasc.SolrCore.initStatsCache Using default
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 5875058 T18846 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 5875059 T18846 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 5875063 T18846 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=287265862,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 5875064 T18846 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@26fa1ae5
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6dfbc460),segFN=segments_1,generation=1}
[junit4] 2> 5875064 T18846 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 5875065 T18846 oass.SolrIndexSearcher.<init> Opening
Searcher@1d894415[collection1] main
[junit4] 2> 5875066 T18846 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 5875070 T18846 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 5875070 T18846 oasr.ManagedResourceStorage.newStorageIO
Setting up ZooKeeper-based storage for the RestManager with znodeBase:
/configs/conf1
[junit4] 2> 5875072 T18846
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 5875072 T18846 oasr.RestManager.init Initializing RestManager
with initArgs: {}
[junit4] 2> 5875072 T18846 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 5875074 T18846
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 5875075 T18846 oasr.ManagedResourceStorage.load Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 5875076 T18846 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 5875076 T18846 oash.ReplicationHandler.inform Commits will be
reserved for 10000
[junit4] 2> 5875077 T18847 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@1d894415[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 5875079 T18846 oasc.CoreContainer.registerCore registering
core: collection1
[junit4] 2> 5875083 T18850 oasc.ZkController.register Register replica -
core:collection1 address:http://127.0.0.1:61122/b_z collection:collection1
shard:shard2
[junit4] 2> 5875084 T18792 oass.SolrDispatchFilter.init
user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 5875085 T18792 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 5875088 T18850 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leader_elect/shard2/election
[junit4] 2> 5875107 T18850
oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for
shard shard2
[junit4] 2> 5875118 T18850
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 5875118 T18850
oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try
and sync
[junit4] 2> ASYNC NEW_CORE C4325 name=collection1
org.apache.solr.core.SolrCore@342e9153
url=http://127.0.0.1:61122/b_z/collection1 node=127.0.0.1:61122_b_z
C4325_STATE=coll:collection1 core:collection1
props:{base_url=http://127.0.0.1:61122/b_z, node_name=127.0.0.1:61122_b_z,
state=down, core=collection1}
[junit4] 2> 5875119 T18850 C4325 P61122 oasc.SyncStrategy.sync Sync
replicas to http://127.0.0.1:61122/b_z/collection1/
[junit4] 2> 5875119 T18850 C4325 P61122 oasc.SyncStrategy.syncReplicas
Sync Success - now sync replicas to me
[junit4] 2> 5875120 T18850 C4325 P61122 oasc.SyncStrategy.syncToMe
http://127.0.0.1:61122/b_z/collection1/ has no replicas
[junit4] 2> 5875120 T18850
oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader:
http://127.0.0.1:61122/b_z/collection1/ shard2
[junit4] 2> 5875121 T18850 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leaders/shard2
[junit4] 2> 5875121 T18818 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5875129 T18819 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"collection1"} current state version: 5
[junit4] 2> 5875136 T18845 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 5875140 T18818 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 5875141 T18829 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 5875166 T18830 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5875171 T18819 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:61122/b_z";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 6
[junit4] 2> 5875286 T18845 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 5875286 T18829 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 5875329 T18850 oasc.ZkController.register We are
http://127.0.0.1:61122/b_z/collection1/ and leader is
http://127.0.0.1:61122/b_z/collection1/
[junit4] 2> 5875330 T18850 oasc.ZkController.register No LogReplay needed
for core=collection1 baseURL=http://127.0.0.1:61122/b_z
[junit4] 2> 5875331 T18850 oasc.ZkController.checkRecovery I am the
leader, no recovery necessary
[junit4] 2> 5875332 T18850 oasc.ZkController.publish publishing
core=collection1 state=active collection=collection1
[junit4] 2> 5875332 T18850 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 5875344 T18830 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5875351 T18819 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "numShards":"2",
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1:61122/b_z";,
[junit4] 2> "shard":"shard2",
[junit4] 2> "roles":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "node_name":"127.0.0.1:61122_b_z",
[junit4] 2> "state":"active",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "core":"collection1"} current state version: 7
[junit4] 2> 5875355 T18819 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "numShards":"2",
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1:61122/b_z";,
[junit4] 2> "shard":"shard2",
[junit4] 2> "roles":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "node_name":"127.0.0.1:61122_b_z",
[junit4] 2> "state":"active",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "core":"collection1"}
[junit4] 2> 5875475 T18818 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 5875477 T18829 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 5875477 T18845 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 5877899 T18792 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2
[junit4] 2> 5877900 T18792 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 5877907 T18792 oejs.AbstractConnector.doStart Started
[email protected]:61125
[junit4] 2> 5877910 T18792 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@6951a712
[junit4] 2> 5877910 T18792 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 5877911 T18792 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-004
[junit4] 2> 5877912 T18792 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-004/'
[junit4] 2> 5877966 T18792 oasc.ConfigSolr.fromFile Loading container
configuration from
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-004/solr.xml
[junit4] 2> 5878041 T18792 oasc.CoreContainer.<init> New CoreContainer
729706545
[junit4] 2> 5878042 T18792 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-004/]
[junit4] 2> 5878043 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 5878044 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 5878044 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 5878044 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 5878045 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 5878046 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 5878046 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 5878047 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 5878048 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 5878048 T18792 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 5878049 T18792 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 5878050 T18792 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 5878050 T18792 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 5878051 T18792 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 5878051 T18792 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:61115/solr
[junit4] 2> 5878052 T18792 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 5878052 T18792
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 5878054 T18792 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5878061 T18862 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@7b93c99f
name:ZooKeeperConnection Watcher:127.0.0.1:61115 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5878061 T18792 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5878062 T18792 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 5878069 T18792 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5878074 T18865 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@7472af34
name:ZooKeeperConnection Watcher:127.0.0.1:61115/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5878075 T18792 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5878099 T18792
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 5879115 T18792 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:61125_b_z
[junit4] 2> 5879118 T18792 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:61125_b_z
[junit4] 2> 5879146 T18792 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 5879173 T18866 oasc.ZkController.publish publishing
core=collection1 state=down collection=collection1
[junit4] 2> 5879174 T18866 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 5879177 T18818 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5879180 T18819 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "numShards":"2",
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1:61125/b_z";,
[junit4] 2> "shard":null,
[junit4] 2> "roles":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "node_name":"127.0.0.1:61125_b_z",
[junit4] 2> "state":"down",
[junit4] 2> "core":"collection1"} current state version: 8
[junit4] 2> 5879181 T18866 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 5879195 T18819 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "numShards":"2",
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1:61125/b_z";,
[junit4] 2> "shard":null,
[junit4] 2> "roles":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "node_name":"127.0.0.1:61125_b_z",
[junit4] 2> "state":"down",
[junit4] 2> "core":"collection1"}
[junit4] 2> 5879195 T18819 oasco.ReplicaMutator.updateState Collection
already exists with numShards=2
[junit4] 2> 5879196 T18819 oasco.ReplicaMutator.updateState Assigning new
node to shard shard=shard1
[junit4] 2> 5879203 T18829 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 5879203 T18818 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 5879203 T18865 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 5879206 T18845 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 5880187 T18866 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for collection1
[junit4] 2> 5880187 T18866 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:collection1
[junit4] 2> 5880189 T18866 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 5880190 T18866 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 5880198 T18866 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 5880198 T18866 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-004/collection1/'
[junit4] 2> 5880200 T18866 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud%203B7851A6C8283EE0-001/tempDir-004/collection1/lib/.svn/'
to classloader
[junit4] 2> 5880201 T18866 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud%203B7851A6C8283EE0-001/tempDir-004/collection1/lib/classes/'
to classloader
[junit4] 2> 5880202 T18866 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud%203B7851A6C8283EE0-001/tempDir-004/collection1/lib/README'
to classloader
[junit4] 2> 5880264 T18866 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 5880272 T18866 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 5880295 T18866 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 5880448 T18866 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 5880540 T18866 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 5880550 T18866 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 5880576 T18866 oass.IndexSchema.readSchema [collection1]
Schema name=test
[junit4] 2> 5881170 T18866 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 5881185 T18866 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 5881187 T18866 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 5881225 T18866 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 5881238 T18866 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 5881249 T18866 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 5881252 T18866
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 5881253 T18866
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 5881253 T18866 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 5881258 T18866
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 5881259 T18866
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 5881259 T18866 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection collection1
[junit4] 2> 5881260 T18866 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 5881260 T18866 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-004/collection1/,
dataDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-001/jetty2/
[junit4] 2> 5881261 T18866 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@277897fb
[junit4] 2> 5881263 T18866 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-001/jetty2
[junit4] 2> 5881263 T18866 oasc.SolrCore.getNewIndexDir New index
directory detected: old=null
new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-001/jetty2/index/
[junit4] 2> 5881263 T18866 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-001/jetty2/index' doesn't exist. Creating new
index...
[junit4] 2> 5881264 T18866 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestSolrConfigHandlerCloud
3B7851A6C8283EE0-001/tempDir-001/jetty2/index
[junit4] 2> 5881265 T18866 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=10, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=99.328125,
floorSegmentMB=1.21484375, forceMergeDeletesPctAllowed=0.0657994511244564,
segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.7934733084749283
[junit4] 2> 5881266 T18866 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@738291ed
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@13a99da),segFN=segments_1,generation=1}
[junit4] 2> 5881266 T18866 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 5881335 T18866 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 5881336 T18866 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 5881338 T18866 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe"
[junit4] 2> 5881338 T18866 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 5881339 T18866 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"stored_sig"
[junit4] 2> 5881340 T18866 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 5881341 T18866 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 5881342 T18866 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 5881342 T18866 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 5881343 T18866 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5881345 T18866 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5881346 T18866 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5881347 T18866 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5881348 T18866 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 5881349 T18866 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 5881351 T18866 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 5881351 T18866 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 5881353 T18866 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 5881354 T18866 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 5881355 T18866 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 5881356 T18866 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 5881357 T18866 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 5881358 T18866 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 5881358 T18866 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 5881359 T18866 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 5881361 T18866 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 5881362 T18866 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 5881384 T18866 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5881388 T18866 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5881391 T18866 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5881395 T18866 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5881398 T18866 oasc.SolrCore.initStatsCache Using default
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 5881401 T18866 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 5881401 T18866 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 5881403 T18866 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=287265862,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 5881403 T18866 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@738291ed
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@13a99da),segFN=segments_1,generation=1}
[junit4] 2> 5881404 T18866 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 5881405 T18866 oass.SolrIndexSearcher.<init> Opening
Searcher@4bf2f0d3[collection1] main
[junit4] 2> 5881405 T18866 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 5881409 T18866 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 5881409 T18866 oasr.ManagedResourceStorage.newStorageIO
Setting up ZooKeeper-based storage for the RestManager with znodeBase:
/configs/conf1
[junit4] 2> 5881411 T18866
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 5881411 T18866 oasr.RestManager.init Initializing RestManager
with initArgs: {}
[junit4] 2> 5881412 T18866 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 5881415 T18866
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 5881415 T18866 oasr.ManagedResourceStorage.load Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 5881416 T18866 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 5881417 T18866 oash.ReplicationHandler.inform Commits will be
reserved for 10000
[junit4] 2> 5881418 T18867 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@4bf2f0d3[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 5881419 T18866 oasc.CoreContainer.registerCore registering
core: collection1
[junit4] 2> 5881422 T18870 oasc.ZkController.register Register replica -
core:collection1 address:http://127.0.0.1:61125/b_z collection:collection1
shard:shard1
[junit4] 2> 5881424 T18792 oass.SolrDispatchFilter.init
user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 5881426 T18870 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leader_elect/shard1/election
[junit4] 2> 5881426 T18792 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 5881459 T18870
oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for
shard shard1
[junit4] 2> 5881470 T18870
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 5881470 T18870
oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try
and sync
[junit4] 2> ASYNC NEW_CORE C4326 name=collection1
org.apache.solr.core.SolrCore@572c05cf
url=http://127.0.0.1:61125/b_z/collection1 node=127.0.0.1:61125_b_z
C4326_STATE=coll:collection1 core:collection1
props:{base_url=http://127.0.0.1:61125/b_z, node_name=127.0.0.1:61125_b_z,
state=down, core=collection1}
[junit4] 2> 5881471 T18870 C4326 P61125 oasc.SyncStrategy.sync Sync
replicas to http://127.0.0.1:61125/b_z/collection1/
[junit4] 2> 5881471 T18870 C4326 P61
[...truncated too long message...]
CoreStressTest, AnalysisErrorHandlingTest, TestValueSourceCache,
PingRequestHandlerTest, PreAnalyzedFieldTest, TestManagedResourceStorage,
SuggesterTest, TestRandomFaceting, LeaderInitiatedRecoveryOnCommitTest,
HighlighterConfigTest, CopyFieldTest, TestSurroundQueryParser,
HdfsBasicDistributedZk2Test, SimpleMLTQParserTest, TestOmitPositions,
TestChildDocTransformer, TestFileDictionaryLookup, TestMiniSolrCloudCluster,
TestLMDirichletSimilarityFactory, TestFreeTextSuggestions,
CurrencyFieldOpenExchangeTest, SimplePostToolTest, ZkCLITest,
TestInfoStreamLogging, TestDocBasedVersionConstraints, RemoteQueryErrorTest,
TestFuzzyAnalyzedSuggestions, TestCloudManagedSchemaConcurrent,
SpellingQueryConverterTest, SignatureUpdateProcessorFactoryTest,
TestExactStatsCache, QueryResultKeyTest, BasicZkTest, TestConfigOverlay,
AlternateDirectoryTest, UnloadDistributedZkTest, RequestHandlersTest,
TestHighlightDedupGrouping, ParsingFieldUpdateProcessorsTest, TestFiltering,
SolrCoreCheckLockOnStartupTest, TestBlobHandler, SimpleFacetsTest,
TestIndexSearcher, TestRecovery, ExitableDirectoryReaderTest,
ShardRoutingCustomTest, TestDistributedGrouping, ReplicationFactorTest,
TestShortCircuitedRequests, RequiredFieldsTest, CSVRequestHandlerTest,
SolrTestCaseJ4Test, TestBM25SimilarityFactory, TestFieldCollectionResource,
TestSuggestSpellingConverter, StatelessScriptUpdateProcessorFactoryTest,
DistanceUnitsTest, TestLMJelinekMercerSimilarityFactory, TestLFUCache,
MergeStrategyTest, MigrateRouteKeyTest, IndexSchemaTest,
OutOfBoxZkACLAndCredentialsProvidersTest,
DistributedQueryComponentOptimizationTest, IndexBasedSpellCheckerTest,
SSLMigrationTest, DOMUtilTest, TestNRTOpen, TestXIncludeConfig,
BasicDistributedZk2Test, FieldAnalysisRequestHandlerTest,
LeaderFailoverAfterPartitionTest, AtomicUpdatesTest,
CoreAdminCreateDiscoverTest, FileUtilsTest, TestDefaultStatsCache,
DistributedTermsComponentTest, SuggesterFSTTest, BlockDirectoryTest,
ZkNodePropsTest, HighlighterTest, CursorPagingTest, LoggingHandlerTest,
OutputWriterTest, TestLRUCache, TestConfigSets, TestJmxIntegration,
ZkStateWriterTest, CustomCollectionTest, TestPHPSerializedResponseWriter,
BlockCacheTest, TestReRankQParserPlugin,
DistributedQueryComponentCustomSortTest, OverseerTest, TestCollectionAPI,
RAMDirectoryFactoryTest, CoreContainerCoreInitFailuresTest, PolyFieldTest,
TestDynamicFieldCollectionResource, PrimitiveFieldTypeTest, TestComponentsName,
DistributedDebugComponentTest, OverseerCollectionProcessorTest,
OverriddenZkACLAndCredentialsProvidersTest, TestRecoveryHdfs,
TestAnalyzeInfixSuggestions, QueryEqualityTest,
DistributedFacetPivotWhiteBoxTest, MultiThreadedOCPTest, ResponseHeaderTest,
TestCharFilters, DistribDocExpirationUpdateProcessorTest,
SharedFSAutoReplicaFailoverUtilsTest, SolrCmdDistributorTest, ZkSolrClientTest,
BufferStoreTest, TestStressUserVersions, TestReload, DateRangeFieldTest,
SuggesterTSTTest, HdfsSyncSliceTest, TestCoreContainer,
HighlighterMaxOffsetTest, ChaosMonkeySafeLeaderTest, ChangedSchemaMergeTest,
TestSolrDynamicMBean, TestStressReorder, TestIBSimilarityFactory, TestRTGBase,
TestImplicitCoreProperties, TestIndexingPerformance, TestTrie, AutoCommitTest,
DistributedSuggestComponentTest, DeleteReplicaTest, BasicDistributedZkTest,
TestReversedWildcardFilterFactory, SliceStateTest, TestCloudInspectUtil,
DocValuesMissingTest, TestZkChroot, TestTolerantSearch, TestReplicaProperties,
TestInitParams, SpellCheckCollatorTest, TestSolr4Spatial,
TestSchemaSimilarityResource, TestFaceting, SuggesterWFSTTest,
TestSchemaManager, StandardRequestHandlerTest, TestInitQParser,
TestSolrCoreProperties, TestClusterStateMutator, TestManagedSchema,
TestCustomSort, SpatialRPTFieldTypeTest, TestDFRSimilarityFactory,
FieldMutatingUpdateProcessorTest, OpenExchangeRatesOrgProviderTest,
TestLeaderElectionZkExpiry, TestSolrJ, SimpleCollectionCreateDeleteTest,
MBeansHandlerTest, TermVectorComponentDistributedTest, SpatialFilterTest,
TestSystemIdResolver, NoCacheHeaderTest, TestWordDelimiterFilterFactory,
TestSchemaNameResource, LukeRequestHandlerTest, ResourceLoaderTest,
TestSolrQueryParserDefaultOperatorResource, FacetPivotSmallTest,
TestFoldingMultitermQuery, TestSolrConfigHandler,
TestDefaultSearchFieldResource, DocumentAnalysisRequestHandlerTest,
SpellCheckComponentTest, ResponseLogComponentTest, TestObjectReleaseTracker,
TestCursorMarkWithoutUniqueKey, DistributedSpellCheckComponentTest,
BJQParserTest, DistributedFacetPivotSmallAdvancedTest, TestBulkSchemaAPI,
TestBinaryField, QueryParsingTest, TestMissingGroups, TestReloadAndDeleteDocs,
SortByFunctionTest, TestJoin, TestStressVersions, TestSolr4Spatial2, TestUtils,
TestRandomMergePolicy, AddSchemaFieldsUpdateProcessorFactoryTest,
TimeZoneUtilsTest, TermsComponentTest, HdfsUnloadDistributedZkTest,
OverseerRolesTest, TestPseudoReturnFields, CollectionsAPIDistributedZkTest,
SyncSliceTest, LeaderElectionIntegrationTest, ShardRoutingTest, RecoveryZkTest,
FullSolrCloudDistribCmdsTest, TestReplicationHandler, LeaderElectionTest,
TestRandomDVFaceting, TestDistributedSearch, TestHashPartitioner,
ZkControllerTest, TestRealTimeGet, HardAutoCommitTest, TestRangeQuery,
SolrCoreTest, TestGroupingSearch, QueryElevationComponentTest, PeerSyncTest,
BadIndexSchemaTest, ConvertedLegacyTest, TestSort, TestFunctionQuery,
BasicFunctionalityTest, TestLazyCores, DirectUpdateHandlerTest,
SoftAutoCommitTest, ShowFileRequestHandlerTest,
DistributedQueryElevationComponentTest, CurrencyFieldXmlFileTest,
SolrIndexSplitterTest, TestCoreDiscovery, AnalysisAfterCoreReloadTest,
TestExtendedDismaxParser, SolrRequestParserTest, TestStressLucene,
TestCSVLoader, WordBreakSolrSpellCheckerTest,
SchemaVersionSpecificBehaviorTest, TestUpdate, TestAtomicUpdateErrorCases,
DefaultValueUpdateProcessorTest, TestRemoteStreaming, DocValuesMultiTest,
DistanceFunctionTest, TestSolrDeletionPolicy1, SolrInfoMBeanTest,
XsltUpdateRequestHandlerTest, DebugComponentTest, CacheHeaderTest,
DisMaxRequestHandlerTest, TestQueryUtils, TestWriterPerf,
DirectSolrSpellCheckerTest, TestQueryTypes, FileBasedSpellCheckerTest,
XmlUpdateRequestHandlerTest, DocumentBuilderTest,
PathHierarchyTokenizerFactoryTest, TermVectorComponentTest,
MoreLikeThisHandlerTest, TestSolrQueryParser, TestArbitraryIndexDir,
FastVectorHighlighterTest, IndexSchemaRuntimeFieldTest,
RegexBoostProcessorTest, SolrPluginUtilsTest, TestCollationField,
ReturnFieldsTest, UpdateRequestProcessorFactoryTest, JSONWriterTest,
TestCSVResponseWriter, TestAnalyzedSuggestions,
UniqFieldsUpdateProcessorFactoryTest, JsonLoaderTest,
BinaryUpdateRequestHandlerTest, TestPartialUpdateDeduplication,
SearchHandlerTest, SOLR749Test, TestQuerySenderListener, UpdateParamsTest,
TestSolrIndexConfig, TestQuerySenderNoQuery, SolrIndexConfigTest,
BadComponentTest, TestStressRecovery, TestMergePolicyConfig,
TestSolrDeletionPolicy2, MultiTermTest, SampleTest, TestDocSet, TestSearchPerf,
NumericFieldsTest, TestElisionMultitermQuery, TestConfig,
ExternalFileFieldSortTest, TestPostingsSolrHighlighter,
DirectSolrConnectionTest, NotRequiredUniqueKeyTest, TestLuceneMatchVersion,
TestPhraseSuggestions, SpellPossibilityIteratorTest, TestCodecSupport,
SynonymTokenizerTest, EchoParamsTest, TestSweetSpotSimilarityFactory,
TestPerFieldSimilarity, TestDefaultSimilarityFactory, TestFastWriter,
LegacyHTMLStripCharFilterTest, TestJmxMonitoredMap, TestFastOutputStream,
ScriptEngineTest, URLClassifyProcessorTest, PluginInfoTest, TestFastLRUCache,
ChaosMonkeyNothingIsSafeTest, PrimUtilsTest, DateFieldTest, ClusterStateTest,
TestDocumentBuilder, SystemInfoHandlerTest, UUIDFieldTest, CircularListTest,
DistributedIntervalFacetingTest, TestDistributedMissingSort,
AliasIntegrationTest, AssignTest, CloudExitableDirectoryReaderTest,
CollectionsAPIAsyncDistributedZkTest, ConnectionManagerTest,
DeleteInactiveReplicaTest, DeleteLastCustomShardedReplicaTest, DeleteShardTest,
DistribCursorPagingTest, DistributedQueueTest, ExternalCollectionsTest,
HttpPartitionTest, OverseerStatusTest, ShardSplitTest,
SharedFSAutoReplicaFailoverTest, SolrXmlInZkTest, TestCloudPivotFacet,
TestDistribDocBasedVersion, TestRequestStatusCollectionAPI,
TriLevelCompositeIdRoutingTest, VMParamsZkACLAndCredentialsProvidersTest,
HdfsBasicDistributedZkTest, HdfsChaosMonkeySafeLeaderTest,
HdfsCollectionsAPIDistributedZkTest, HdfsRecoveryZkTest,
HdfsWriteToMultipleCollectionsTest, CachingDirectoryFactoryTest,
TestDynamicLoading, TestShardHandlerFactory, TestSolrXml,
TestSolrXmlPersistence, TestSolrXmlPersistor, TestConfigReload,
TestReplicationHandlerBackup, TestSolrConfigHandlerCloud]
[junit4] Completed in 54.81s, 1 test, 1 failure <<< FAILURES!
[...truncated 193 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:529: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:477: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:61: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/extra-targets.xml:39: The
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build.xml:190: The
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/common-build.xml:508: The
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:1363:
The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:970:
There were test failures: 460 suites, 1874 tests, 1 failure, 52 ignored (21
assumptions)
Total time: 170 minutes 47 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.7.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: [email protected]
For additional commands, e-mail: [email protected]
