Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-MacOSX/1910/
Java: 64bit/jdk1.7.0 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC (asserts:
false)
1 tests failed.
FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testDistribSearch
Error Message:
some core start times did not change on reload
Stack Trace:
java.lang.AssertionError: some core start times did not change on reload
at
__randomizedtesting.SeedInfo.seed([B2E40A0D454A5104:3302841532153138]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testCollectionsAPI(CollectionsAPIDistributedZkTest.java:884)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.doTest(CollectionsAPIDistributedZkTest.java:203)
at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
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 11606 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/init-core-data-001
[junit4] 2> 5128942 T11771 oas.SolrTestCaseJ4.buildSSLConfig Randomized
ssl (false) and clientAuth (false)
[junit4] 2> 5128943 T11771
oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system
property: /
[junit4] 2> 5128952 T11771 oas.SolrTestCaseJ4.setUp ###Starting
testDistribSearch
[junit4] 2> 5128953 T11771 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 5128955 T11772 oasc.ZkTestServer$ZKServerMain.runFromConfig
Starting server
[junit4] 2> 5129054 T11771 oasc.ZkTestServer.run start zk server on
port:59999
[junit4] 2> 5129055 T11771
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 5129057 T11771 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5129068 T11779 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@4acc5621
name:ZooKeeperConnection Watcher:127.0.0.1:59999 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5129069 T11771 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5129070 T11771 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 5129070 T11771 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 5129082 T11771
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 5129086 T11771 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5129090 T11782 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@6838dacb
name:ZooKeeperConnection Watcher:127.0.0.1:59999/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5129091 T11771 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5129091 T11771 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 5129092 T11771 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 5129101 T11771 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 5129110 T11771 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 5129116 T11771 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 5129125 T11771 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> 5129126 T11771 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 5129137 T11771 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> 5129138 T11771 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 5129144 T11771 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> 5129145 T11771 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 5129155 T11771 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> 5129156 T11771 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 5129164 T11771 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> 5129164 T11771 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 5129170 T11771 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> 5129171 T11771 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 5129177 T11771 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> 5129178 T11771 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 5129185 T11771 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> 5129185 T11771 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 5129192 T11771 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> 5129192 T11771 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 5129199 T11771 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> 5129199 T11771 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 5129205 T11771 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> 5129205 T11771 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> Using new style solr.xml
[junit4] 2> 5131237 T11771 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 5131246 T11771 oejs.AbstractConnector.doStart Started
[email protected]:60002
[junit4] 2> 5131249 T11771 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 5131249 T11771 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 5131250 T11771 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.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-002
[junit4] 2> 5131250 T11771 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-002/'
[junit4] 2> 5131315 T11771 oasc.ConfigSolr.fromFile Loading container
configuration from
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-002/solr.xml
[junit4] 2> 5131386 T11771 oasc.CorePropertiesLocator.<init>
Config-defined core root directory:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-002
[junit4] 2> 5131387 T11771 oasc.CoreContainer.<init> New CoreContainer
993983052
[junit4] 2> 5131387 T11771 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-002/]
[junit4] 2> 5131388 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 5131389 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 5131389 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 5131389 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 5131390 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 5131390 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 5131390 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 5131391 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 5131391 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 5131391 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 5131392 T11771 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 5131392 T11771 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 5131393 T11771 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 5131393 T11771 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 5131393 T11771 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:59999/solr
[junit4] 2> 5131394 T11771 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 5131395 T11771
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 5131396 T11771 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5131400 T11794 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@37424e65
name:ZooKeeperConnection Watcher:127.0.0.1:59999 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5131402 T11771 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5131402 T11771 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 5131408 T11771 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5131412 T11797 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@2a1ead7c
name:ZooKeeperConnection Watcher:127.0.0.1:59999/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5131412 T11771 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5131416 T11771 oascc.SolrZkClient.makePath makePath:
/overseer/queue
[junit4] 2> 5131424 T11771 oascc.SolrZkClient.makePath makePath:
/overseer/collection-queue-work
[junit4] 2> 5131433 T11771 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-running
[junit4] 2> 5131444 T11771 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-completed
[junit4] 2> 5131453 T11771 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-failure
[junit4] 2> 5131464 T11771 oascc.SolrZkClient.makePath makePath:
/live_nodes
[junit4] 2> 5131469 T11771 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60002_
[junit4] 2> 5131470 T11771 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:60002_
[junit4] 2> 5131479 T11771 oascc.SolrZkClient.makePath makePath:
/overseer_elect
[junit4] 2> 5131485 T11771 oascc.SolrZkClient.makePath makePath:
/overseer_elect/election
[junit4] 2> 5131493 T11771 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 5131501 T11771 oasc.OverseerElectionContext.runLeaderProcess I
am going to be the leader 127.0.0.1:60002_
[junit4] 2> 5131502 T11771 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 5131512 T11771 oasc.Overseer.start Overseer
(id=92847270637207555-127.0.0.1:60002_-n_0000000000) starting
[junit4] 2> 5131520 T11771 oascc.SolrZkClient.makePath makePath:
/overseer/queue-work
[junit4] 2> 5131556 T11771 oasc.OverseerAutoReplicaFailoverThread.<init>
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=10000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 5131559 T11799 oasc.OverseerCollectionProcessor.run Process
current queue of collection creations
[junit4] 2> 5131562 T11771 oascc.SolrZkClient.makePath makePath:
/clusterstate.json
[junit4] 2> 5131571 T11771 oascc.SolrZkClient.makePath makePath:
/aliases.json
[junit4] 2> 5131576 T11771
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 5131598 T11798 oasc.Overseer$ClusterStateUpdater.run Starting
to work on the main queue
[junit4] 2> 5131946 T11771 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-002
[junit4] 2> 5132617 T11771 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-002/conf/
[junit4] 2> 5132722 T11771 oasc.CorePropertiesLocator.discover Found 1
core definitions
[junit4] 2> 5132725 T11771 oass.SolrDispatchFilter.init
user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 5132726 T11771 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 5132727 T11771
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 5132728 T11771 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5132735 T11804 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@64cde597
name:ZooKeeperConnection Watcher:127.0.0.1:59999/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5132736 T11771 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5132736 T11771 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 5132741 T11771
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 5132753 T11771 oasc.ChaosMonkey.monkeyLog monkey: init -
expire sessions:false cause connection loss:false
[junit4] 2> 5132753 T11771 oasc.AbstractFullDistribZkTestBase.createJettys
Creating collection1 with stateFormat=2
[junit4] 2> 5132754 T11771
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 5132756 T11771 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5132764 T11807 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5f4d34b1
name:ZooKeeperConnection Watcher:127.0.0.1:59999/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5132765 T11771 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5132765 T11771 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 5132775 T11797 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5132791 T11798
oasc.Overseer$ClusterStateUpdater.buildCollection building a new collection:
collection1
[junit4] 2> 5132791 T11798
oasc.Overseer$ClusterStateUpdater.createCollection Create collection
collection1 with shards [shard1, shard2]
[junit4] 2> 5132792 T11798
oasc.Overseer$ClusterStateUpdater.createCollection state version collection1 2
[junit4] 2> 5132805 T11798
oasc.Overseer$ClusterStateUpdater.updateZkStates going to create_collection
/collections/collection1/state.json
[junit4] 2> 5132811 T11797 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> 5132812 T11804 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> 5134452 T11771 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1
[junit4] 2> 5134453 T11771 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 5134459 T11771 oejs.AbstractConnector.doStart Started
[email protected]:60007
[junit4] 2> 5134461 T11771 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 5134461 T11771 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 5134462 T11771 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.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003
[junit4] 2> 5134462 T11771 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003/'
[junit4] 2> 5134517 T11771 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.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003/solr.xml
[junit4] 2> 5134576 T11771 oasc.CorePropertiesLocator.<init>
Config-defined core root directory:
/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.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003
[junit4] 2> 5134576 T11771 oasc.CoreContainer.<init> New CoreContainer
231261936
[junit4] 2> 5134577 T11771 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003/]
[junit4] 2> 5134578 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 5134579 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 5134579 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 5134579 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 5134580 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 5134580 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 5134580 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 5134581 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 5134581 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 5134582 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 5134582 T11771 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 5134583 T11771 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 5134583 T11771 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 5134583 T11771 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 5134583 T11771 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:59999/solr
[junit4] 2> 5134584 T11771 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 5134584 T11771
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 5134586 T11771 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5134589 T11819 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@733de998
name:ZooKeeperConnection Watcher:127.0.0.1:59999 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5134591 T11771 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5134591 T11771 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 5134598 T11771 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5134603 T11822 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@239931b1
name:ZooKeeperConnection Watcher:127.0.0.1:59999/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5134603 T11771 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5134624 T11771
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 5135644 T11771 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60007_
[junit4] 2> 5135649 T11771 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:60007_
[junit4] 2> 5135664 T11771 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 5135674 T11771 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/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.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003
[junit4] 2> 5136612 T11771 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
/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.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003/conf/
[junit4] 2> 5136735 T11771 oasc.CorePropertiesLocator.discover Found 1
core definitions
[junit4] 2> 5136738 T11771 oass.SolrDispatchFilter.init
user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 5136739 T11771 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 5138646 T11771 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2
[junit4] 2> 5138647 T11771 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 5138654 T11771 oejs.AbstractConnector.doStart Started
[email protected]:60010
[junit4] 2> 5138656 T11771 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 5138657 T11771 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 5138657 T11771 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.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004
[junit4] 2> 5138658 T11771 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004/'
[junit4] 2> 5138718 T11771 oasc.ConfigSolr.fromFile Loading container
configuration from
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004/solr.xml
[junit4] 2> 5138788 T11771 oasc.CorePropertiesLocator.<init>
Config-defined core root directory:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004
[junit4] 2> 5138789 T11771 oasc.CoreContainer.<init> New CoreContainer
168340062
[junit4] 2> 5138789 T11771 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004/]
[junit4] 2> 5138791 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 5138791 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 5138792 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 5138792 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 5138793 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 5138793 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 5138794 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 5138795 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 5138796 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 5138797 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 5138797 T11771 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 5138798 T11771 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 5138799 T11771 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 5138800 T11771 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 5138800 T11771 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:59999/solr
[junit4] 2> 5138802 T11771 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 5138803 T11771
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 5138805 T11771 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5138808 T11835 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@403a0e7b
name:ZooKeeperConnection Watcher:127.0.0.1:59999 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5138810 T11771 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5138811 T11771 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 5138820 T11771 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5138825 T11838 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@67c0715a
name:ZooKeeperConnection Watcher:127.0.0.1:59999/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5138826 T11771 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5138850 T11771
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 5139871 T11771 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60010_
[junit4] 2> 5139874 T11771 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:60010_
[junit4] 2> 5139895 T11771 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 5139910 T11771 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004
[junit4] 2> 5140586 T11771 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004/conf/
[junit4] 2> 5140693 T11771 oasc.CorePropertiesLocator.discover Found 1
core definitions
[junit4] 2> 5140695 T11771 oass.SolrDispatchFilter.init
user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 5140696 T11771 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 5142538 T11771 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 3
[junit4] 2> 5142539 T11771 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 5142545 T11771 oejs.AbstractConnector.doStart Started
[email protected]:60013
[junit4] 2> 5142548 T11771 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 5142548 T11771 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 5142548 T11771 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.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005
[junit4] 2> 5142549 T11771 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005/'
[junit4] 2> 5142605 T11771 oasc.ConfigSolr.fromFile Loading container
configuration from
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005/solr.xml
[junit4] 2> 5142658 T11771 oasc.CorePropertiesLocator.<init>
Config-defined core root directory:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005
[junit4] 2> 5142658 T11771 oasc.CoreContainer.<init> New CoreContainer
1843400362
[junit4] 2> 5142659 T11771 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005/]
[junit4] 2> 5142660 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 5142660 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 5142661 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 5142661 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 5142662 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 5142662 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 5142662 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 5142663 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 5142663 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 5142663 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 5142664 T11771 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 5142664 T11771 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 5142664 T11771 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 5142665 T11771 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 5142666 T11771 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:59999/solr
[junit4] 2> 5142666 T11771 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 5142666 T11771
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 5142668 T11771 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5142674 T11851 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@3c7cd00c
name:ZooKeeperConnection Watcher:127.0.0.1:59999 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5142675 T11771 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5142677 T11771 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 5142684 T11771 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5142690 T11854 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@23514650
name:ZooKeeperConnection Watcher:127.0.0.1:59999/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5142690 T11771 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5142716 T11771
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 5143740 T11771 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60013_
[junit4] 2> 5143744 T11771 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:60013_
[junit4] 2> 5143766 T11771 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 5143776 T11771 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005
[junit4] 2> 5144519 T11771 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005/conf/
[junit4] 2> 5144622 T11771 oasc.CorePropertiesLocator.discover Found 1
core definitions
[junit4] 2> 5144625 T11771 oass.SolrDispatchFilter.init
user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 5144626 T11771 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 5146597 T11771 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 4
[junit4] 2> 5146598 T11771 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 5146605 T11771 oejs.AbstractConnector.doStart Started
[email protected]:60016
[junit4] 2> 5146608 T11771 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 5146608 T11771 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 5146609 T11771 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.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-006
[junit4] 2> 5146609 T11771 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-006/'
[junit4] 2> 5146661 T11771 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.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-006/solr.xml
[junit4] 2> 5146732 T11771 oasc.CorePropertiesLocator.<init>
Config-defined core root directory:
/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.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-006
[junit4] 2> 5146732 T11771 oasc.CoreContainer.<init> New CoreContainer
1300781065
[junit4] 2> 5146732 T11771 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-006/]
[junit4] 2> 5146734 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 5146735 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 5146735 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 5146736 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 5146736 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 5146736 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 5146736 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 5146737 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 5146737 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 5146737 T11771 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 5146737 T11771 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 5146738 T11771 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 5146739 T11771 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 5146739 T11771 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 5146739 T11771 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:59999/solr
[junit4] 2> 5146740 T11771 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 5146740 T11771
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 5146741 T11771 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5146746 T11867 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@64bb7ee8
name:ZooKeeperConnection Watcher:127.0.0.1:59999 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5146749 T11771 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5146750 T11771 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 5146764 T11771 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5146770 T11870 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@720805 name:ZooKeeperConnection
Watcher:127.0.0.1:59999/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 5146771 T11771 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5146791 T11771
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 5147813 T11771 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60016_
[junit4] 2> 5147818 T11771 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:60016_
[junit4] 2> 5147842 T11771 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 5147858 T11771 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/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.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-006
[junit4] 2> 5148724 T11771 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
/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.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-006/conf/
[junit4] 2> 5148829 T11771 oasc.CorePropertiesLocator.discover Found 1
core definitions
[junit4] 2> 5148832 T11771 oass.SolrDispatchFilter.init
user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 5148833 T11771 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 5148843 T11815 oasha.CollectionsHandler.handleCreateAction
Creating Collection :
name=solrj_collection&numShards=2&version=2&action=CREATE&replicationFactor=2&wt=javabin&router.field=myOwnField&collection.configName=conf1
[junit4] 2> 5148845 T11797 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/collection-queue-work state
SyncConnected
[junit4] 2> 5148848 T11799 oasc.OverseerCollectionProcessor.run Overseer
Collection Processor: Get the message
id:/overseer/collection-queue-work/qn-0000000000 message:{
[junit4] 2> "operation":"create",
[junit4] 2> "fromApi":"true",
[junit4] 2> "name":"solrj_collection",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "collection.configName":"conf1",
[junit4] 2> "numShards":"2",
[junit4] 2> "router.field":"myOwnField"}
[junit4] 2> 5148852 T11872 oasc.OverseerCollectionProcessor.processMessage
WARN OverseerCollectionProcessor.processMessage : create , {
[junit4] 2> "operation":"create",
[junit4] 2> "fromApi":"true",
[junit4] 2> "name":"solrj_collection",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "collection.configName":"conf1",
[junit4] 2> "numShards":"2",
[junit4] 2> "router.field":"myOwnField"}
[junit4] 2> 5148854 T11872 oasc.OverseerCollectionProcessor.createConfNode
creating collections conf node /collections/solrj_collection
[junit4] 2> 5148855 T11872 oascc.SolrZkClient.makePath makePath:
/collections/solrj_collection
[junit4] 2> 5148866 T11797 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5148877 T11798
oasc.Overseer$ClusterStateUpdater.buildCollection building a new collection:
solrj_collection
[junit4] 2> 5148878 T11798
oasc.Overseer$ClusterStateUpdater.createCollection Create collection
solrj_collection with shards [shard1, shard2]
[junit4] 2> 5148878 T11798
oasc.Overseer$ClusterStateUpdater.createCollection state version
solrj_collection 1
[junit4] 2> 5148887 T11804 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 5148887 T11854 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 5148888 T11838 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 5148888 T11870 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 5148888 T11822 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 5148887 T11797 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 5148967 T11872
oasc.OverseerCollectionProcessor.createCollection Creating SolrCores for new
collection solrj_collection, shardNames [shard1, shard2] , replicationFactor : 2
[junit4] 2> 5148967 T11872
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard1_replica1 as part of slice shard1 of collection
solrj_collection on 127.0.0.1:60007_
[junit4] 2> 5148969 T11872
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard1_replica2 as part of slice shard1 of collection
solrj_collection on 127.0.0.1:60013_
[junit4] 2> 5148972 T11872
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard2_replica1 as part of slice shard2 of collection
solrj_collection on 127.0.0.1:60016_
[junit4] 2> 5148976 T11810 oasha.CoreAdminHandler.handleCreateAction core
create command
name=solrj_collection_shard1_replica1&collection=solrj_collection&numShards=2&version=2&action=CREATE&wt=javabin&qt=/admin/cores&shard=shard1&collection.configName=conf1
[junit4] 2> 5148978 T11847 oasha.CoreAdminHandler.handleCreateAction core
create command
name=solrj_collection_shard1_replica2&collection=solrj_collection&numShards=2&version=2&action=CREATE&wt=javabin&qt=/admin/cores&shard=shard1&collection.configName=conf1
[junit4] 2> 5148980 T11872
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard2_replica2 as part of slice shard2 of collection
solrj_collection on 127.0.0.1:60010_
[junit4] 2> 5148983 T11810 oasc.ZkController.publish publishing
core=solrj_collection_shard1_replica1 state=down collection=solrj_collection
[junit4] 2> 5148984 T11864 oasha.CoreAdminHandler.handleCreateAction core
create command
name=solrj_collection_shard2_replica1&collection=solrj_collection&numShards=2&version=2&action=CREATE&wt=javabin&qt=/admin/cores&shard=shard2&collection.configName=conf1
[junit4] 2> 5148986 T11810 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 5148986 T11847 oasc.ZkController.publish publishing
core=solrj_collection_shard1_replica2 state=down collection=solrj_collection
[junit4] 2> 5148988 T11797 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5148989 T11847 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 5148989 T11864 oasc.ZkController.publish publishing
core=solrj_collection_shard2_replica1 state=down collection=solrj_collection
[junit4] 2> 5148991 T11864 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 5148994 T11832 oasha.CoreAdminHandler.handleCreateAction core
create command
name=solrj_collection_shard2_replica2&collection=solrj_collection&numShards=2&version=2&action=CREATE&wt=javabin&qt=/admin/cores&shard=shard2&collection.configName=conf1
[junit4] 2> 5148997 T11832 oasc.ZkController.publish publishing
core=solrj_collection_shard2_replica2 state=down collection=solrj_collection
[junit4] 2> 5148999 T11832 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 5149002 T11798 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "base_url":"http://127.0.0.1:60007";,
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "numShards":"2",
[junit4] 2> "core":"solrj_collection_shard1_replica1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:60007_",
[junit4] 2> "roles":null,
[junit4] 2> "shard":"shard1"}
[junit4] 2> 5149010 T11798 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "base_url":"http://127.0.0.1:60013";,
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "numShards":"2",
[junit4] 2> "core":"solrj_collection_shard1_replica2",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:60013_",
[junit4] 2> "roles":null,
[junit4] 2> "shard":"shard1"}
[junit4] 2> 5149016 T11797 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5149018 T11798 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "base_url":"http://127.0.0.1:60016";,
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "numShards":"2",
[junit4] 2> "core":"solrj_collection_shard2_replica1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:60016_",
[junit4] 2> "roles":null,
[junit4] 2> "shard":"shard2"}
[junit4] 2> 5149026 T11798 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "base_url":"http://127.0.0.1:60010";,
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "numShards":"2",
[junit4] 2> "core":"solrj_collection_shard2_replica2",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:60010_",
[junit4] 2> "roles":null,
[junit4] 2> "shard":"shard2"}
[junit4] 2> 5149032 T11797 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5149136 T11870 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 5149137 T11804 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 5149138 T11854 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 5149137 T11838 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 5149138 T11822 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 5149140 T11797 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 5149987 T11810 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for solrj_collection_shard1_replica1
[junit4] 2> 5149988 T11810 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 5149989 T11847 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for solrj_collection_shard1_replica2
[junit4] 2> 5149990 T11847 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 5149991 T11810 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 5149991 T11810 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 5149992 T11864 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for solrj_collection_shard2_replica1
[junit4] 2> 5149993 T11864 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 5149994 T11847 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 5149994 T11847 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 5149998 T11864 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 5149999 T11864 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 5150002 T11832 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for solrj_collection_shard2_replica2
[junit4] 2> 5150002 T11832 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 5150002 T11810 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 5150004 T11847 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 5150004 T11847 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005/solrj_collection_shard1_replica2/'
[junit4] 2> 5150004 T11810 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003/solrj_collection_shard1_replica1/'
[junit4] 2> 5150007 T11864 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 5150008 T11864 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-006/solrj_collection_shard2_replica1/'
[junit4] 2> 5150015 T11832 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 5150015 T11832 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 5150038 T11832 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 5150039 T11832 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004/solrj_collection_shard2_replica2/'
[junit4] 2> 5150253 T11832 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 5150258 T11847 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 5150282 T11810 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 5150286 T11864 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 5150420 T11832 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 5150431 T11847 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 5150434 T11864 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 5150435 T11832 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 5150439 T11864 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 5150449 T11847 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 5150453 T11810 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 5150459 T11847 oass.IndexSchema.readSchema
[solrj_collection_shard1_replica2] Schema name=test
[junit4] 2> 5150464 T11810 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 5150472 T11832 oass.IndexSchema.readSchema
[solrj_collection_shard2_replica2] Schema name=test
[junit4] 2> 5150477 T11810 oass.IndexSchema.readSchema
[solrj_collection_shard1_replica1] Schema name=test
[junit4] 2> 5150518 T11864 oass.IndexSchema.readSchema
[solrj_collection_shard2_replica1] Schema name=test
[junit4] 2> 5151598 T11847 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 5151655 T11847 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 5151659 T11847 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 5151691 T11810 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 5151704 T11832 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 5151709 T11810 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 5151736 T11810 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 5151737 T11832 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 5151742 T11832 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 5151769 T11864 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 5151805 T11847 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 5151807 T11810 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 5151818 T11847 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 5151822 T11810 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 5151825 T11847 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 5151827 T11832 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 5151832 T11847
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 5151843 T11847
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 5151847 T11847 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 5151834 T11864 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 5151850 T11832 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 5151851 T11810 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 5151852 T11864 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 5151853 T11810
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 5151854 T11810
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 5151854 T11810 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 5151856 T11847
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 5151856 T11847
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 5151865 T11847 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard1_replica2' using configuration from collection
solrj_collection
[junit4] 2> 5151865 T11847 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 5151858 T11810
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 5151867 T11810
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 5151869 T11810 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard1_replica1' using configuration from collection
solrj_collection
[junit4] 2> 5151866 T11847 oasc.SolrCore.<init>
[solrj_collection_shard1_replica2] Opening new SolrCore at
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005/solrj_collection_shard1_replica2/,
dataDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005/solrj_collection_shard1_replica2/data/
[junit4] 2> 5151870 T11847 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2dab769e
[junit4] 2> 5151869 T11810 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 5151865 T11832 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 5151872 T11847 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005/solrj_collection_shard1_replica2/data
[junit4] 2> 5151876 T11847 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.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005/solrj_collection_shard1_replica2/data/index/
[junit4] 2> 5151876 T11847 oasc.SolrCore.initIndex WARN
[solrj_collection_shard1_replica2] Solr index directory
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005/solrj_collection_shard1_replica2/data/index'
doesn't exist. Creating new index...
[junit4] 2> 5151876 T11832
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 5151878 T11847 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005/solrj_collection_shard1_replica2/data/index
[junit4] 2> 5151881 T11847 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=46, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=14.9384765625,
floorSegmentMB=0.8671875, forceMergeDeletesPctAllowed=0.023491033878365597,
segmentsPerTier=20.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 5151879 T11810 oasc.SolrCore.<init>
[solrj_collection_shard1_replica1] Opening new SolrCore at
../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003/solrj_collection_shard1_replica1/,
dataDir=/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.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003/solrj_collection_shard1_replica1/data/
[junit4] 2> 5151883 T11810 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2dab769e
[junit4] 2> 5151878 T11832
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 5151885 T11832 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 5151885 T11810 oasc.CachingDirectoryFactory.get return new
directory for
/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.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003/solrj_collection_shard1_replica1/data
[junit4] 2> 5151887 T11810 oasc.SolrCore.getNewIndexDir New index
directory detected: old=null
new=/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.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003/solrj_collection_shard1_replica1/data/index/
[junit4] 2> 5151887 T11810 oasc.SolrCore.initIndex WARN
[solrj_collection_shard1_replica1] Solr index directory
'/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.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003/solrj_collection_shard1_replica1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 5151888 T11810 oasc.CachingDirectoryFactory.get return new
directory for
/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.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003/solrj_collection_shard1_replica1/data/index
[junit4] 2> 5151888 T11847 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@696704f
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ea755e9),segFN=segments_1,generation=1}
[junit4] 2> 5151890 T11847 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 5151891 T11810 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=46, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=14.9384765625,
floorSegmentMB=0.8671875, forceMergeDeletesPctAllowed=0.023491033878365597,
segmentsPerTier=20.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 5151892 T11810 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@d14eb26
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@585a127f),segFN=segments_1,generation=1}
[junit4] 2> 5151892 T11810 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 5151895 T11832
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 5151895 T11832
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 5151896 T11832 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard2_replica2' using configuration from collection
solrj_collection
[junit4] 2> 5151896 T11832 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 5151897 T11832 oasc.SolrCore.<init>
[solrj_collection_shard2_replica2] Opening new SolrCore at
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004/solrj_collection_shard2_replica2/,
dataDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004/solrj_collection_shard2_replica2/data/
[junit4] 2> 5151898 T11832 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2dab769e
[junit4] 2> 5151899 T11832 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004/solrj_collection_shard2_replica2/data
[junit4] 2> 5151900 T11832 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.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004/solrj_collection_shard2_replica2/data/index/
[junit4] 2> 5151902 T11832 oasc.SolrCore.initIndex WARN
[solrj_collection_shard2_replica2] Solr index directory
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004/solrj_collection_shard2_replica2/data/index'
doesn't exist. Creating new index...
[junit4] 2> 5151903 T11832 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004/solrj_collection_shard2_replica2/data/index
[junit4] 2> 5151903 T11832 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=46, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=14.9384765625,
floorSegmentMB=0.8671875, forceMergeDeletesPctAllowed=0.023491033878365597,
segmentsPerTier=20.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 5151904 T11832 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d898849
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@30527fc5),segFN=segments_1,generation=1}
[junit4] 2> 5151905 T11832 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 5151901 T11847 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 5151907 T11847 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 5151908 T11847 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe"
[junit4] 2> 5151908 T11847 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 5151908 T11847 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"stored_sig"
[junit4] 2> 5151908 T11847 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 5151909 T11847 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 5151909 T11847 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 5151910 T11847 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 5151911 T11847 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5151911 T11847 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5151912 T11847 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5151913 T11847 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 5151913 T11847 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 5151914 T11847 oasc.RequestHandlers.initHandlersFromConfig
adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 5151915 T11847 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 5151912 T11832 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 5151918 T11864 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 5151920 T11847 oasc.RequestHandlers.initHandlersFromConfig
created /update: solr.UpdateRequestHandler
[junit4] 2> 5151922 T11847 oasc.RequestHandlers.initHandlersFromConfig
created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 5151913 T11810 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 5151919 T11832 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 5151923 T11847 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 5151925 T11847 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 5151924 T11832 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe"
[junit4] 2> 5151929 T11832 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 5151929 T11832 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"stored_sig"
[junit4] 2> 5151930 T11832 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 5151930 T11832 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 5151931 T11832 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 5151931 T11832 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 5151932 T11832 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5151933 T11832 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5151933 T11832 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5151934 T11832 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 5151935 T11832 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 5151935 T11832 oasc.RequestHandlers.initHandlersFromConfig
adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 5151936 T11832 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 5151937 T11832 oasc.RequestHandlers.initHandlersFromConfig
created /update: solr.UpdateRequestHandler
[junit4] 2> 5151938 T11832 oasc.RequestHandlers.initHandlersFromConfig
created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 5151939 T11832 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 5151939 T11832 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 5151940 T11864 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 5151940 T11810 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 5151945 T11810 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe"
[junit4] 2> 5151945 T11810 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 5151946 T11847 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5151947 T11832 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5151948 T11847 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5151949 T11832 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5151946 T11810 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"stored_sig"
[junit4] 2> 5151950 T11810 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 5151954 T11810 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 5151954 T11810 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 5151955 T11810 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 5151949 T11847 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5151962 T11847 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5151963 T11864 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 5151958 T11810 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5151966 T11810 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5151954 T11832 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5151968 T11810 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5151971 T11832 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5151973 T11847 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 5151973 T11847 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 5151974 T11847 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=20, maxMergeAtOnceExplicit=22, maxMergedSegmentMB=25.2314453125,
floorSegmentMB=0.75390625, forceMergeDeletesPctAllowed=0.05507263694569886,
segmentsPerTier=35.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.7172019855143539
[junit4] 2> 5151974 T11810 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 5151975 T11810 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 5151981 T11810 oasc.RequestHandlers.initHandlersFromConfig
adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 5151981 T11810 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 5151982 T11810 oasc.RequestHandlers.initHandlersFromConfig
created /update: solr.UpdateRequestHandler
[junit4] 2> 5151980 T11832 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 5151983 T11832 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 5151975 T11864
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 5151984 T11864
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 5151984 T11864 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 5151984 T11832 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=20, maxMergeAtOnceExplicit=22, maxMergedSegmentMB=25.2314453125,
floorSegmentMB=0.75390625, forceMergeDeletesPctAllowed=0.05507263694569886,
segmentsPerTier=35.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.7172019855143539
[junit4] 2> 5151983 T11810 oasc.RequestHandlers.initHandlersFromConfig
created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 5151981 T11847 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@696704f
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ea755e9),segFN=segments_1,generation=1}
[junit4] 2> 5151987 T11847 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 5151989 T11847 oass.SolrIndexSearcher.<init> Opening
Searcher@a48622a[solrj_collection_shard1_replica2] main
[junit4] 2> 5151990 T11847 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 5151988 T11832 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1d898849
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@30527fc5),segFN=segments_1,generation=1}
[junit4] 2> 5151991 T11832 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 5151991 T11832 oass.SolrIndexSearcher.<init> Opening
Searcher@44d82f8f[solrj_collection_shard2_replica2] main
[junit4] 2> 5151991 T11832 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 5151992 T11847 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 5151993 T11847 oasr.ManagedResourceStorage.newStorageIO
Setting up ZooKeeper-based storage for the RestManager with znodeBase:
/configs/conf1
[junit4] 2> 5151988 T11864
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 5151995 T11847
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 5151995 T11847 oasr.RestManager.init Initializing RestManager
with initArgs: {}
[junit4] 2> 5151996 T11847 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 5151987 T11810 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 5151997 T11847
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 5151997 T11847 oasr.ManagedResourceStorage.load Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 5151995 T11864
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 5151999 T11864 oasc.CoreContainer.create Creating
[...truncated too long message...]
T11771 oasc.CachingDirectoryFactory.close Closing directory:
/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.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-006/nodes_used_collection_shard2_replica1/data/index
[junit4] 2> 5253111 T11771 oasc.Overseer.close Overseer
(id=92847270637207565-127.0.0.1:60016_-n_0000000004) closing
[junit4] 2> 5253112 T11995 oasc.Overseer$ClusterStateUpdater.run Overseer
Loop exiting : 127.0.0.1:60016_
[junit4] 2> 5253119 T11959 oascc.ZkStateReader$3.process WARN ZooKeeper
watch triggered, but Solr cannot talk to ZK
[junit4] 2> 5253139 T11771 oejsh.ContextHandler.doStop stopped
o.e.j.s.ServletContextHandler{/,null}
[junit4] 2> 5258121 T11771 oas.SolrTestCaseJ4.tearDown ###Ending
testDistribSearch
[junit4] 2> 5258125 T11771 oasc.ZkTestServer.send4LetterWord connecting to
127.0.0.1:59999 59999
[junit4] 2> 5258130 T11971 oasc.ZkTestServer.send4LetterWord connecting to
127.0.0.1:59999 59999
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=CollectionsAPIDistributedZkTest -Dtests.method=testDistribSearch
-Dtests.seed=B2E40A0D454A5104 -Dtests.slow=true -Dtests.locale=en_IN
-Dtests.timezone=Asia/Irkutsk -Dtests.asserts=false
-Dtests.file.encoding=US-ASCII
[junit4] FAILURE 130s | CollectionsAPIDistributedZkTest.testDistribSearch
<<<
[junit4] > Throwable #1: java.lang.AssertionError: some core start times
did not change on reload
[junit4] > at
__randomizedtesting.SeedInfo.seed([B2E40A0D454A5104:3302841532153138]:0)
[junit4] > at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testCollectionsAPI(CollectionsAPIDistributedZkTest.java:884)
[junit4] > at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.doTest(CollectionsAPIDistributedZkTest.java:203)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 5258831 T11771 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50):
{id=PostingsFormat(name=LuceneFixedGap),
range_facet_l=PostingsFormat(name=LuceneVarGapFixedInterval),
multiDefault=PostingsFormat(name=Memory doPackFST= true),
text=PostingsFormat(name=Direct),
intDefault=PostingsFormat(name=LuceneVarGapFixedInterval),
other_tl1=PostingsFormat(name=LuceneVarGapFixedInterval),
a_i1=PostingsFormat(name=LuceneVarGapFixedInterval),
a_t=PostingsFormat(name=LuceneVarGapFixedInterval),
timestamp=PostingsFormat(name=LuceneVarGapFixedInterval),
_version_=PostingsFormat(name=LuceneVarGapFixedInterval)},
docValues:{timestamp=DocValuesFormat(name=Lucene50)}, sim=DefaultSimilarity,
locale=en_IN, timezone=Asia/Irkutsk
[junit4] 2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.7.0_67
(64-bit)/cpus=2,threads=1,free=180811296,total=336039936
[junit4] 2> NOTE: All tests run in this JVM: [AlternateDirectoryTest,
TestHashPartitioner, TestManagedSchemaDynamicFieldResource,
TestWordDelimiterFilterFactory, TestSolrCoreProperties, TestModifyConfFiles,
DateMathParserTest, TestComponentsName, XsltUpdateRequestHandlerTest,
ResponseLogComponentTest, TestReplicationHandler, TestFaceting, BJQParserTest,
HdfsChaosMonkeySafeLeaderTest, BinaryUpdateRequestHandlerTest,
MoreLikeThisHandlerTest, CircularListTest, TestCoreContainer,
TestSolrQueryParser, TestDocumentBuilder, TestCharFilters,
TestRandomMergePolicy, TestRestManager, PeerSyncTest, TestSchemaResource,
TestHighFrequencyDictionaryFactory, DistributedFacetPivotSmallTest,
BadIndexSchemaTest, TestDefaultSearchFieldResource, SpellCheckCollatorTest,
SharedFSAutoReplicaFailoverTest, FileUtilsTest, ExitableDirectoryReaderTest,
JSONWriterTest, TestAnalyzedSuggestions, HardAutoCommitTest,
FacetPivotSmallTest, DistributedQueueTest, CoreAdminCreateDiscoverTest,
SolrIndexSplitterTest, HdfsBasicDistributedZkTest, HttpPartitionTest,
SimplePostToolTest, TestFieldTypeResource, TestFreeTextSuggestions,
OverseerRolesTest, SOLR749Test, SuggesterTest, TestSweetSpotSimilarityFactory,
DOMUtilTest, TestCloudManagedSchema, TestZkChroot, FileBasedSpellCheckerTest,
TriLevelCompositeIdRoutingTest, WordBreakSolrSpellCheckerTest,
QueryParsingTest, ExternalFileFieldSortTest, TestRequestStatusCollectionAPI,
SolrRequestParserTest, CacheHeaderTest, DistributedIntervalFacetingTest,
DirectSolrSpellCheckerTest, TestSchemaSimilarityResource, MergeStrategyTest,
TestReplicaProperties, TestCSVResponseWriter, AnalysisAfterCoreReloadTest,
HighlighterMaxOffsetTest, HdfsBasicDistributedZk2Test, TermVectorComponentTest,
TestManagedSchemaFieldResource, RequestHandlersTest, CoreAdminHandlerTest,
TestOrdValues, ShardRoutingTest, TestBlendedInfixSuggestions,
TestSolrDynamicMBean, TestRangeQuery, SolrXmlInZkTest,
StatelessScriptUpdateProcessorFactoryTest, AnalyticsMergeStrategyTest,
TestDistributedSearch, SyncSliceTest, TestWriterPerf, ClusterStateTest,
TestShortCircuitedRequests, TestDistributedMissingSort, TestInitQParser,
TestOverriddenPrefixQueryForCustomFieldType, TestNRTOpen, QueryResultKeyTest,
TestFastLRUCache, ShardSplitTest, SolrPluginUtilsTest,
ChaosMonkeySafeLeaderTest, CloudMLTQParserTest, TestQuerySenderNoQuery,
AnalysisErrorHandlingTest, FieldAnalysisRequestHandlerTest, UUIDFieldTest,
TestStressUserVersions, TestCollectionAPI, TestFieldSortValues, TestSolrXml,
RankQueryTest, TestDocSet, TestDynamicFieldCollectionResource,
CloudExitableDirectoryReaderTest, LeaderInitiatedRecoveryOnCommitTest,
TestSearchPerf, TestCustomSort, CurrencyFieldOpenExchangeTest,
URLClassifyProcessorTest, TestOmitPositions, TestUpdate, EnumFieldTest,
VMParamsZkACLAndCredentialsProvidersTest, TermsComponentTest,
ResourceLoaderTest, TestSolr4Spatial2, LukeRequestHandlerTest,
TestDistribDocBasedVersion, BadComponentTest, QueryEqualityTest,
TestMissingGroups, TestJmxMonitoredMap, ZkSolrClientTest, SolrIndexConfigTest,
TimeZoneUtilsTest, CSVRequestHandlerTest,
DistribDocExpirationUpdateProcessorTest, DistanceFunctionTest, TestReload,
DirectUpdateHandlerOptimizeTest, TestNonDefinedSimilarityFactory,
SuggesterTSTTest, SharedFSAutoReplicaFailoverUtilsTest, DocValuesTest,
DirectSolrConnectionTest, TestDefaultSimilarityFactory,
TestReversedWildcardFilterFactory, AliasIntegrationTest, MigrateRouteKeyTest,
DocValuesMissingTest, TestSolrDeletionPolicy2, SolrTestCaseJ4Test,
SignatureUpdateProcessorFactoryTest, RegexBoostProcessorTest,
DistribCursorPagingTest, BadCopyFieldTest, TestIndexSearcher,
HdfsCollectionsAPIDistributedZkTest, DeleteLastCustomShardedReplicaTest,
DefaultValueUpdateProcessorTest, ConvertedLegacyTest,
XmlUpdateRequestHandlerTest, TestSurroundQueryParser, TestJoin, TestLazyCores,
TestInitParams, TestManagedSchemaFieldTypeResource, FastVectorHighlighterTest,
AddBlockUpdateTest, TestNoOpRegenerator, ChaosMonkeyNothingIsSafeTest,
SynonymTokenizerTest, TestStandardQParsers, DirectUpdateHandlerTest,
TestSolrQueryParserResource, TestSolrIndexConfig, ShardRoutingCustomTest,
ModifyConfFileTest, DistributedDebugComponentTest, TestGroupingSearch,
IndexSchemaTest, TestSimpleQParserPlugin, TestStressRecovery,
SoftAutoCommitTest, ReplicationFactorTest, TestFastWriter,
TestReRankQParserPlugin, TestStressVersions, IndexSchemaRuntimeFieldTest,
TermVectorComponentDistributedTest, CoreMergeIndexesAdminHandlerTest,
IndexBasedSpellCheckerTest, SchemaVersionSpecificBehaviorTest,
TestSchemaManager, CopyFieldTest, FieldMutatingUpdateProcessorTest,
TestRecoveryHdfs, JsonLoaderTest, TestSolrXmlPersistence,
TestCloudManagedSchemaConcurrent, QueryElevationComponentTest,
TestUniqueKeyFieldResource, CoreContainerCoreInitFailuresTest,
TestAnalyzeInfixSuggestions, UUIDUpdateProcessorFallbackTest,
TestLMDirichletSimilarityFactory, BlockCacheTest,
SimpleCollectionCreateDeleteTest, TestSolrQueryParserDefaultOperatorResource,
MultiThreadedOCPTest, SpellPossibilityIteratorTest, RemoteQueryErrorTest,
TestValueSourceCache, TestSolrXmlPersistor, TestDFRSimilarityFactory,
TestSearcherReuse, CursorPagingTest, TestBulkSchemaAPI,
TestCopyFieldCollectionResource, BasicDistributedZkTest,
BasicDistributedZk2Test, UnloadDistributedZkTest,
CollectionsAPIDistributedZkTest]
[junit4] Completed in 129.94s, 1 test, 1 failure <<< FAILURES!
[...truncated 699 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:525: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:473: 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:189: 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:1359:
The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:966:
There were test failures: 445 suites, 1819 tests, 1 failure, 49 ignored (20
assumptions)
Total time: 196 minutes 0 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.7.0
-XX:+UseCompressedOops -XX:+UseConcMarkSweepGC (asserts: false)
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]
