Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-5.x/636/
1 tests failed.
FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testDistribSearch
Error Message:
Error CREATEing SolrCore 'halfcollection_shard1_replica1': Unable to create
core [halfcollection_shard1_replica1] Caused by: null
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: Error
CREATEing SolrCore 'halfcollection_shard1_replica1': Unable to create core
[halfcollection_shard1_replica1] Caused by: null
at
org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:568)
at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:215)
at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:211)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testErrorHandling(CollectionsAPIDistributedZkTest.java:583)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.doTest(CollectionsAPIDistributedZkTest.java:205)
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:43)
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 11622 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/init-core-data-001
[junit4] 2> 447874 T1129 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(false) and clientAuth (false)
[junit4] 2> 447875 T1129 oas.BaseDistributedSearchTestCase.initHostContext
Setting hostContext system property: /
[junit4] 2> 447887 T1129 oas.SolrTestCaseJ4.setUp ###Starting
testDistribSearch
[junit4] 2> 447889 T1129 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 447890 T1130 oasc.ZkTestServer$ZKServerMain.runFromConfig
Starting server
[junit4] 2> 447990 T1129 oasc.ZkTestServer.run start zk server on
port:32088
[junit4] 2> 447991 T1129
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 447992 T1129 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 447999 T1136 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5f3df1e7
name:ZooKeeperConnection Watcher:127.0.0.1:32088 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 448000 T1129 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 448001 T1129 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 448001 T1129 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 448006 T1129
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 448008 T1129 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 448010 T1138 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@65d40076
name:ZooKeeperConnection Watcher:127.0.0.1:32088/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 448010 T1129 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 448011 T1129 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 448011 T1129 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 448016 T1129 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 448019 T1129 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 448022 T1129 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 448025 T1129 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 448026 T1129 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 448032 T1129 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 448033 T1129 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 448037 T1129 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 448038 T1129 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 448042 T1129 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 448043 T1129 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 448047 T1129 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 448048 T1129 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 448051 T1129 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 448052 T1129 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 448056 T1129 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 448057 T1129 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 448060 T1129 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 448062 T1129 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 448065 T1129 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 448066 T1129 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 448069 T1129 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 448070 T1129 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 448073 T1129 oasc.AbstractZkTestCase.putConfig put
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 448074 T1129 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> Using new style solr.xml
[junit4] 2> 450312 T1129 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 450316 T1129 oejs.AbstractConnector.doStart Started
[email protected]:32097
[junit4] 2> 450317 T1129 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 450317 T1129 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 450318 T1129 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-002
[junit4] 2> 450318 T1129 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-002/'
[junit4] 2> 450374 T1129 oasc.ConfigSolr.fromFile Loading container
configuration from
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-002/solr.xml
[junit4] 2> 450477 T1129 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-002
[junit4] 2> 450478 T1129 oasc.CoreContainer.<init> New CoreContainer
927824809
[junit4] 2> 450478 T1129 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-002/]
[junit4] 2> 450480 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 450481 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 450482 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 450482 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 450483 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 450483 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 450484 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 450484 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 450485 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 450486 T1129 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 450487 T1129 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 450488 T1129 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 450488 T1129 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 450489 T1129 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:32088/solr
[junit4] 2> 450490 T1129 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 450490 T1129
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 450492 T1129 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 450495 T1149 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@3ff1b09c
name:ZooKeeperConnection Watcher:127.0.0.1:32088 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 450497 T1129 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 450498 T1129 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 450502 T1129 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 450504 T1151 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5aaed393
name:ZooKeeperConnection Watcher:127.0.0.1:32088/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 450504 T1129 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 450508 T1129 oascc.SolrZkClient.makePath makePath:
/overseer/queue
[junit4] 2> 450512 T1129 oascc.SolrZkClient.makePath makePath:
/overseer/collection-queue-work
[junit4] 2> 450517 T1129 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-running
[junit4] 2> 450523 T1129 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-completed
[junit4] 2> 450528 T1129 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-failure
[junit4] 2> 450533 T1129 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 450536 T1129 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:32097_
[junit4] 2> 450537 T1129 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:32097_
[junit4] 2> 450542 T1129 oascc.SolrZkClient.makePath makePath:
/overseer_elect
[junit4] 2> 450545 T1129 oascc.SolrZkClient.makePath makePath:
/overseer_elect/election
[junit4] 2> 450547 T1129 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 450550 T1129 oasc.OverseerElectionContext.runLeaderProcess I
am going to be the leader 127.0.0.1:32097_
[junit4] 2> 450551 T1129 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 450553 T1129 oasc.Overseer.start Overseer
(id=92539852977602563-127.0.0.1:32097_-n_0000000000) starting
[junit4] 2> 450557 T1129 oascc.SolrZkClient.makePath makePath:
/overseer/queue-work
[junit4] 2> 450568 T1129 oasc.OverseerAutoReplicaFailoverThread.<init>
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=10000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 450569 T1153 oasc.OverseerCollectionProcessor.run Process
current queue of collection creations
[junit4] 2> 450571 T1129 oascc.SolrZkClient.makePath makePath:
/clusterstate.json
[junit4] 2> 450574 T1129 oascc.SolrZkClient.makePath makePath:
/aliases.json
[junit4] 2> 450577 T1129
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 450583 T1152 oasc.Overseer$ClusterStateUpdater.run Starting to
work on the main queue
[junit4] 2> 450592 T1129 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-002
[junit4] 2> 450605 T1129 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-002/conf/
[junit4] 2> 453083 T1129 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 453085 T1129 oass.SolrDispatchFilter.init
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3
[junit4] 2> 453085 T1129 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 453086 T1129
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 453087 T1129 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 453089 T1157 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@51db9d13
name:ZooKeeperConnection Watcher:127.0.0.1:32088/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 453089 T1129 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 453090 T1129 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 453092 T1129
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 453096 T1129 oasc.ChaosMonkey.monkeyLog monkey: init - expire
sessions:false cause connection loss:false
[junit4] 2> 453096 T1129 oasc.AbstractFullDistribZkTestBase.createJettys
Creating collection1 with stateFormat=2
[junit4] 2> 453097 T1129
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 453098 T1129 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 453100 T1159 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@67119fe4
name:ZooKeeperConnection Watcher:127.0.0.1:32088/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 453100 T1129 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 453100 T1129 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 453104 T1160 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 453108 T1152 oasc.Overseer$ClusterStateUpdater.buildCollection
building a new collection: collection1
[junit4] 2> 453108 T1152
oasc.Overseer$ClusterStateUpdater.createCollection Create collection
collection1 with shards [shard1, shard2]
[junit4] 2> 453108 T1152
oasc.Overseer$ClusterStateUpdater.createCollection state version collection1 2
[junit4] 2> 453112 T1152 oasc.Overseer$ClusterStateUpdater.updateZkStates
going to create_collection /collections/collection1/state.json
[junit4] 2> 453114 T1160 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> 453114 T1161 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> 455046 T1129 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1
[junit4] 2> 455048 T1129 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 455051 T1129 oejs.AbstractConnector.doStart Started
[email protected]:32104
[junit4] 2> 455053 T1129 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 455053 T1129 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 455054 T1129 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-003
[junit4] 2> 455054 T1129 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-003/'
[junit4] 2> 455151 T1129 oasc.ConfigSolr.fromFile Loading container
configuration from
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-003/solr.xml
[junit4] 2> 455260 T1129 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-003
[junit4] 2> 455260 T1129 oasc.CoreContainer.<init> New CoreContainer
942883397
[junit4] 2> 455261 T1129 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-003/]
[junit4] 2> 455266 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 455267 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 455267 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 455268 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 455268 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 455269 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 455269 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 455270 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 455270 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 455271 T1129 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 455272 T1129 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 455272 T1129 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 455273 T1129 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 455273 T1129 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:32088/solr
[junit4] 2> 455274 T1129 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 455274 T1129
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 455275 T1129 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 455277 T1172 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@2d43dcd6
name:ZooKeeperConnection Watcher:127.0.0.1:32088 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 455279 T1129 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 455279 T1129 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 455282 T1129 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 455284 T1174 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1feedc7 name:ZooKeeperConnection
Watcher:127.0.0.1:32088/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 455284 T1129 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 455293 T1129
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 456309 T1129 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:32104_
[junit4] 2> 456311 T1129 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:32104_
[junit4] 2> 456318 T1129 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 456327 T1129 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-003
[junit4] 2> 456662 T1129 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-003/conf/
[junit4] 2> 458357 T1129 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 458359 T1129 oass.SolrDispatchFilter.init
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3
[junit4] 2> 458359 T1129 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 460343 T1129 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2
[junit4] 2> 460344 T1129 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 460348 T1129 oejs.AbstractConnector.doStart Started
[email protected]:32112
[junit4] 2> 460349 T1129 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 460349 T1129 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 460350 T1129 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-004
[junit4] 2> 460350 T1129 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-004/'
[junit4] 2> 460404 T1129 oasc.ConfigSolr.fromFile Loading container
configuration from
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-004/solr.xml
[junit4] 2> 460513 T1129 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-004
[junit4] 2> 460514 T1129 oasc.CoreContainer.<init> New CoreContainer
420856053
[junit4] 2> 460515 T1129 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-004/]
[junit4] 2> 460518 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 460518 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 460519 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 460519 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 460520 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 460520 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 460521 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 460521 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 460522 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 460522 T1129 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 460523 T1129 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 460523 T1129 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 460524 T1129 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 460525 T1129 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:32088/solr
[junit4] 2> 460525 T1129 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 460526 T1129
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 460527 T1129 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 460529 T1187 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@632f21b0
name:ZooKeeperConnection Watcher:127.0.0.1:32088 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 460530 T1129 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 460531 T1129 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 460535 T1129 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 460537 T1189 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@7d7ff2c3
name:ZooKeeperConnection Watcher:127.0.0.1:32088/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 460537 T1129 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 460546 T1129
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 461553 T1129 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:32112_
[junit4] 2> 461555 T1129 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:32112_
[junit4] 2> 461562 T1129 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 461572 T1129 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-004
[junit4] 2> 461680 T1129 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-004/conf/
[junit4] 2> 463607 T1129 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 463609 T1129 oass.SolrDispatchFilter.init
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3
[junit4] 2> 463609 T1129 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 465571 T1129 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 3
[junit4] 2> 465572 T1129 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 465576 T1129 oejs.AbstractConnector.doStart Started
[email protected]:32125
[junit4] 2> 465577 T1129 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 465577 T1129 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 465578 T1129 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-005
[junit4] 2> 465578 T1129 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-005/'
[junit4] 2> 465637 T1129 oasc.ConfigSolr.fromFile Loading container
configuration from
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-005/solr.xml
[junit4] 2> 465719 T1129 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-005
[junit4] 2> 465720 T1129 oasc.CoreContainer.<init> New CoreContainer
641499378
[junit4] 2> 465720 T1129 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-005/]
[junit4] 2> 465722 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 465722 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 465723 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 465723 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 465724 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 465724 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 465725 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 465725 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 465725 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 465726 T1129 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 465727 T1129 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 465727 T1129 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 465728 T1129 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 465728 T1129 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:32088/solr
[junit4] 2> 465729 T1129 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 465729 T1129
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 465730 T1129 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 465732 T1202 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@4e35a37a
name:ZooKeeperConnection Watcher:127.0.0.1:32088 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 465733 T1129 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 465734 T1129 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 465737 T1129 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 465738 T1204 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@55d770a0
name:ZooKeeperConnection Watcher:127.0.0.1:32088/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 465739 T1129 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 465747 T1129
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 466754 T1129 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:32125_
[junit4] 2> 466756 T1129 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:32125_
[junit4] 2> 466761 T1129 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 466768 T1129 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-005
[junit4] 2> 468352 T1129 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-005/conf/
[junit4] 2> 468777 T1129 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 468779 T1129 oass.SolrDispatchFilter.init
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3
[junit4] 2> 468779 T1129 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 470246 T1129 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 4
[junit4] 2> 470247 T1129 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 470250 T1129 oejs.AbstractConnector.doStart Started
[email protected]:32129
[junit4] 2> 470251 T1129 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 470251 T1129 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 470251 T1129 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-006
[junit4] 2> 470252 T1129 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-006/'
[junit4] 2> 470329 T1129 oasc.ConfigSolr.fromFile Loading container
configuration from
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-006/solr.xml
[junit4] 2> 470399 T1129 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-006
[junit4] 2> 470400 T1129 oasc.CoreContainer.<init> New CoreContainer
1284285005
[junit4] 2> 470400 T1129 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-006/]
[junit4] 2> 470401 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 470402 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 470402 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 470402 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 470403 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 470403 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 470403 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 470404 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 470404 T1129 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 470405 T1129 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 470405 T1129 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 470405 T1129 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 470406 T1129 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 470406 T1129 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:32088/solr
[junit4] 2> 470406 T1129 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 470407 T1129
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 470407 T1129 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 470409 T1217 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@24f3947e
name:ZooKeeperConnection Watcher:127.0.0.1:32088 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 470410 T1129 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 470410 T1129 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 470412 T1129 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 470413 T1219 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1220a635
name:ZooKeeperConnection Watcher:127.0.0.1:32088/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 470414 T1129 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 470420 T1129
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 471425 T1129 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:32129_
[junit4] 2> 471426 T1129 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:32129_
[junit4] 2> 471431 T1129 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 471439 T1129 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-006
[junit4] 2> 471573 T1129 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-006/conf/
[junit4] 2> 472740 T1129 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 472741 T1129 oass.SolrDispatchFilter.init
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3
[junit4] 2> 472742 T1129 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 472776 T1166 oasha.CollectionsHandler.handleCreateAction
Creating Collection :
version=2&replicationFactor=2&router.field=myOwnField&numShards=2&wt=javabin&collection.configName=conf1&name=solrj_collection&action=CREATE
[junit4] 2> 472778 T1160 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/collection-queue-work state:
SyncConnected type NodeChildrenChanged
[junit4] 2> 472780 T1153 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> 472789 T1222 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> 472796 T1222 oasc.OverseerCollectionProcessor.createConfNode
creating collections conf node /collections/solrj_collection
[junit4] 2> 472797 T1222 oascc.SolrZkClient.makePath makePath:
/collections/solrj_collection
[junit4] 2> 472801 T1160 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 472806 T1152 oasc.Overseer$ClusterStateUpdater.buildCollection
building a new collection: solrj_collection
[junit4] 2> 472806 T1152
oasc.Overseer$ClusterStateUpdater.createCollection Create collection
solrj_collection with shards [shard1, shard2]
[junit4] 2> 472806 T1152
oasc.Overseer$ClusterStateUpdater.createCollection state version
solrj_collection 1
[junit4] 2> 472810 T1175 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> 472810 T1220 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> 472810 T1160 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> 472810 T1190 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> 472810 T1205 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> 472810 T1161 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> 472902 T1222 oasc.OverseerCollectionProcessor.createCollection
Creating SolrCores for new collection solrj_collection, shardNames [shard1,
shard2] , replicationFactor : 2
[junit4] 2> 472903 T1222 oasc.OverseerCollectionProcessor.createCollection
Creating shard solrj_collection_shard1_replica1 as part of slice shard1 of
collection solrj_collection on 127.0.0.1:32112_
[junit4] 2> 472904 T1222 oasc.OverseerCollectionProcessor.createCollection
Creating shard solrj_collection_shard1_replica2 as part of slice shard1 of
collection solrj_collection on 127.0.0.1:32104_
[junit4] 2> 472907 T1222 oasc.OverseerCollectionProcessor.createCollection
Creating shard solrj_collection_shard2_replica1 as part of slice shard2 of
collection solrj_collection on 127.0.0.1:32097_
[junit4] 2> 472909 T1222 oasc.OverseerCollectionProcessor.createCollection
Creating shard solrj_collection_shard2_replica2 as part of slice shard2 of
collection solrj_collection on 127.0.0.1:32125_
[junit4] 2> 472910 T1180 oasha.CoreAdminHandler.handleCreateAction core
create command
version=2&numShards=2&qt=/admin/cores&collection=solrj_collection&wt=javabin&collection.configName=conf1&name=solrj_collection_shard1_replica1&shard=shard1&action=CREATE
[junit4] 2> 472910 T1167 oasha.CoreAdminHandler.handleCreateAction core
create command
version=2&numShards=2&qt=/admin/cores&collection=solrj_collection&wt=javabin&collection.configName=conf1&name=solrj_collection_shard1_replica2&shard=shard1&action=CREATE
[junit4] 2> 472912 T1146 oasha.CoreAdminHandler.handleCreateAction core
create command
version=2&numShards=2&qt=/admin/cores&collection=solrj_collection&wt=javabin&collection.configName=conf1&name=solrj_collection_shard2_replica1&shard=shard2&action=CREATE
[junit4] 2> 472914 T1196 oasha.CoreAdminHandler.handleCreateAction core
create command
version=2&numShards=2&qt=/admin/cores&collection=solrj_collection&wt=javabin&collection.configName=conf1&name=solrj_collection_shard2_replica2&shard=shard2&action=CREATE
[junit4] 2> 472942 T1196 oasc.ZkController.publish publishing
core=solrj_collection_shard2_replica2 state=down collection=solrj_collection
[junit4] 2> 472942 T1146 oasc.ZkController.publish publishing
core=solrj_collection_shard2_replica1 state=down collection=solrj_collection
[junit4] 2> 472942 T1180 oasc.ZkController.publish publishing
core=solrj_collection_shard1_replica1 state=down collection=solrj_collection
[junit4] 2> 472944 T1160 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 472942 T1167 oasc.ZkController.publish publishing
core=solrj_collection_shard1_replica2 state=down collection=solrj_collection
[junit4] 2> 472944 T1146 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 472944 T1196 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 472945 T1180 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 472946 T1167 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 472950 T1152 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "state":"down",
[junit4] 2> "numShards":"2",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "core":"solrj_collection_shard2_replica2",
[junit4] 2> "base_url":"http://127.0.0.1:32125";,
[junit4] 2> "roles":null,
[junit4] 2> "shard":"shard2",
[junit4] 2> "node_name":"127.0.0.1:32125_",
[junit4] 2> "operation":"state"}
[junit4] 2> 472954 T1152 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "state":"down",
[junit4] 2> "numShards":"2",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "core":"solrj_collection_shard2_replica1",
[junit4] 2> "base_url":"http://127.0.0.1:32097";,
[junit4] 2> "roles":null,
[junit4] 2> "shard":"shard2",
[junit4] 2> "node_name":"127.0.0.1:32097_",
[junit4] 2> "operation":"state"}
[junit4] 2> 472957 T1160 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 472959 T1152 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "state":"down",
[junit4] 2> "numShards":"2",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "core":"solrj_collection_shard1_replica1",
[junit4] 2> "base_url":"http://127.0.0.1:32112";,
[junit4] 2> "roles":null,
[junit4] 2> "shard":"shard1",
[junit4] 2> "node_name":"127.0.0.1:32112_",
[junit4] 2> "operation":"state"}
[junit4] 2> 472963 T1152 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "state":"down",
[junit4] 2> "numShards":"2",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "core":"solrj_collection_shard1_replica2",
[junit4] 2> "base_url":"http://127.0.0.1:32104";,
[junit4] 2> "roles":null,
[junit4] 2> "shard":"shard1",
[junit4] 2> "node_name":"127.0.0.1:32104_",
[junit4] 2> "operation":"state"}
[junit4] 2> 472966 T1160 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 472968 T1160 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> 472968 T1205 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> 472968 T1190 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> 472968 T1175 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> 472968 T1161 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> 472968 T1220 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> 473945 T1146 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard2_replica1
[junit4] 2> 473946 T1146 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 473946 T1196 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard2_replica2
[junit4] 2> 473947 T1146 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 473947 T1180 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard1_replica1
[junit4] 2> 473947 T1196 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 473948 T1146 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 473947 T1167 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard1_replica2
[junit4] 2> 473949 T1196 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 473948 T1180 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 473950 T1196 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 473950 T1146 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 473950 T1167 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 473952 T1196 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 473952 T1146 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-002/solrj_collection_shard2_replica1/'
[junit4] 2> 473951 T1180 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 473953 T1196 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-005/solrj_collection_shard2_replica2/'
[junit4] 2> 473953 T1167 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 473954 T1180 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 473955 T1167 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 473956 T1180 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 473957 T1180 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-004/solrj_collection_shard1_replica1/'
[junit4] 2> 473957 T1167 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 473958 T1167 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-003/solrj_collection_shard1_replica2/'
[junit4] 2> 474164 T1167 oasc.SolrConfig.<init> Using Lucene MatchVersion:
5.0.0
[junit4] 2> 474166 T1180 oasc.SolrConfig.<init> Using Lucene MatchVersion:
5.0.0
[junit4] 2> 474167 T1196 oasc.SolrConfig.<init> Using Lucene MatchVersion:
5.0.0
[junit4] 2> 474169 T1146 oasc.SolrConfig.<init> Using Lucene MatchVersion:
5.0.0
[junit4] 2> 474259 T1167 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 474261 T1167 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 474266 T1196 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 474268 T1196 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 474271 T1180 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 474271 T1146 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 474273 T1180 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 474273 T1146 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 474305 T1167 oass.IndexSchema.readSchema
[solrj_collection_shard1_replica2] Schema name=test
[junit4] 2> 474312 T1196 oass.IndexSchema.readSchema
[solrj_collection_shard2_replica2] Schema name=test
[junit4] 2> 474314 T1146 oass.IndexSchema.readSchema
[solrj_collection_shard2_replica1] Schema name=test
[junit4] 2> 474325 T1180 oass.IndexSchema.readSchema
[solrj_collection_shard1_replica1] Schema name=test
[junit4] 2> 474991 T1146 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 474996 T1167 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 474997 T1180 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 475008 T1146 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 475010 T1180 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 475010 T1167 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 475013 T1196 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 475014 T1146 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 475014 T1180 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 475015 T1167 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 475022 T1196 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 475026 T1196 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 475040 T1167 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 475040 T1146 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 475040 T1180 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 475049 T1167 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 475049 T1180 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 475049 T1146 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 475052 T1196 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 475074 T1167 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 475074 T1196 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 475074 T1146 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 475076 T1167
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 475074 T1180 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 475079 T1146
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 475079 T1167
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 475080 T1180
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 475080 T1146
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 475081 T1180
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 475081 T1167 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 475083 T1180 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 475082 T1146 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 475084 T1167
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 475084 T1196 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 475085 T1146
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 475085 T1167
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 475085 T1180
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 475087 T1167 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard1_replica2' using configuration from collection
solrj_collection
[junit4] 2> 475086 T1196
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 475086 T1146
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 475088 T1196
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 475088 T1167 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 475087 T1180
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 475090 T1167 oasc.SolrCore.<init>
[solrj_collection_shard1_replica2] Opening new SolrCore at
../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-003/solrj_collection_shard1_replica2/,
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-003/solrj_collection_shard1_replica2/data/
[junit4] 2> 475089 T1196 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 475089 T1146 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard2_replica1' using configuration from collection
solrj_collection
[junit4] 2> 475093 T1167 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@25f556c5
[junit4] 2> 475091 T1180 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard1_replica1' using configuration from collection
solrj_collection
[junit4] 2> 475094 T1196
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 475094 T1146 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 475096 T1196
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 475095 T1180 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 475097 T1196 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard2_replica2' using configuration from collection
solrj_collection
[junit4] 2> 475096 T1146 oasc.SolrCore.<init>
[solrj_collection_shard2_replica1] Opening new SolrCore at
../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-002/solrj_collection_shard2_replica1/,
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-002/solrj_collection_shard2_replica1/data/
[junit4] 2> 475098 T1196 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 475097 T1180 oasc.SolrCore.<init>
[solrj_collection_shard1_replica1] Opening new SolrCore at
../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-004/solrj_collection_shard1_replica1/,
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-004/solrj_collection_shard1_replica1/data/
[junit4] 2> 475097 T1167 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-003/solrj_collection_shard1_replica2/data
[junit4] 2> 475100 T1180 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@25f556c5
[junit4] 2> 475099 T1196 oasc.SolrCore.<init>
[solrj_collection_shard2_replica2] Opening new SolrCore at
../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-005/solrj_collection_shard2_replica2/,
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-005/solrj_collection_shard2_replica2/data/
[junit4] 2> 475098 T1146 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@25f556c5
[junit4] 2> 475101 T1196 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@25f556c5
[junit4] 2> 475101 T1167 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-003/solrj_collection_shard1_replica2/data/index/
[junit4] 2> 475103 T1167 oasc.SolrCore.initIndex WARN
[solrj_collection_shard1_replica2] Solr index directory
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-003/solrj_collection_shard1_replica2/data/index'
doesn't exist. Creating new index...
[junit4] 2> 475103 T1167 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-003/solrj_collection_shard1_replica2/data/index
[junit4] 2> 475104 T1167 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1212431635,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 475105 T1180 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-004/solrj_collection_shard1_replica1/data
[junit4] 2> 475106 T1167 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory(id=lucene-71fc7d4c)),segFN=segments_1,generation=1}
[junit4] 2> 475106 T1167 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 475106 T1146 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-002/solrj_collection_shard2_replica1/data
[junit4] 2> 475107 T1180 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-004/solrj_collection_shard1_replica1/data/index/
[junit4] 2> 475107 T1196 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-005/solrj_collection_shard2_replica2/data
[junit4] 2> 475108 T1180 oasc.SolrCore.initIndex WARN
[solrj_collection_shard1_replica1] Solr index directory
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-004/solrj_collection_shard1_replica1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 475108 T1146 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-002/solrj_collection_shard2_replica1/data/index/
[junit4] 2> 475109 T1180 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-004/solrj_collection_shard1_replica1/data/index
[junit4] 2> 475109 T1196 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-005/solrj_collection_shard2_replica2/data/index/
[junit4] 2> 475111 T1180 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1212431635,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 475112 T1196 oasc.SolrCore.initIndex WARN
[solrj_collection_shard2_replica2] Solr index directory
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-005/solrj_collection_shard2_replica2/data/index'
doesn't exist. Creating new index...
[junit4] 2> 475110 T1146 oasc.SolrCore.initIndex WARN
[solrj_collection_shard2_replica1] Solr index directory
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-002/solrj_collection_shard2_replica1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 475113 T1196 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-005/solrj_collection_shard2_replica2/data/index
[junit4] 2> 475114 T1146 oasc.CachingDirectoryFactory.get return new
directory for
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/../../../../../../../../../../../usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001/tempDir-002/solrj_collection_shard2_replica1/data/index
[junit4] 2> 475113 T1180 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory(id=lucene-3e21abae)),segFN=segments_1,generation=1}
[junit4] 2> 475115 T1146 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1212431635,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 475114 T1196 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1212431635,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 475114 T1167 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 475117 T1196 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory(id=lucene-543a9587)),segFN=segments_1,generation=1}
[junit4] 2> 475117 T1146 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory(id=lucene-5454114)),segFN=segments_1,generation=1}
[junit4] 2> 475115 T1180 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 475118 T1146 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 475118 T1196 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 475127 T1196 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 475127 T1180 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 475127 T1146 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 475261 T1167 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 475261 T1180 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 475261 T1196 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 475261 T1146 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 475263 T1196 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 475262 T1180 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 475262 T1167 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 475264 T1180 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 475264 T1196 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 475263 T1146 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 475266 T1196 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 475266 T1180 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 475265 T1167 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 475268 T1180 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 475267 T1196 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 475267 T1146 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 475270 T1196 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 475270 T1146 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 475271 T1146 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 475269 T1180 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 475268 T1167 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 475273 T1180 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 475272 T1146 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 475275 T1180 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 475271 T1196 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 475275 T1146 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 475277 T1146 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 475273 T1167 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 475279 T1146 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 475276 T1180 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 475280 T1146 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 475281 T1180 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler
[...truncated too long message...]
2097]
[junit4] > at
org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:322)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrServer.sendRequest(CloudSolrServer.java:880)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrServer.requestWithRetryOnStaleState(CloudSolrServer.java:658)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrServer.request(CloudSolrServer.java:601)
[junit4] > at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1548)
[junit4] > at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1569)
[junit4] > at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:1037)
[junit4] > Caused by:
org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: Could not
fully create collection: awholynewstresscollection_collection2_1
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:568)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:215)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:211)
[junit4] > at
org.apache.solr.client.solrj.impl.LBHttpSolrServer.doRequest(LBHttpSolrServer.java:343)
[junit4] > at
org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:304)
[junit4] > ... 6 moreThrowable #6:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=1597, name=Thread-463, state=RUNNABLE,
group=TGRP-CollectionsAPIDistributedZkTest]
[junit4] > Caused by: java.lang.RuntimeException:
org.apache.solr.client.solrj.SolrServerException: No live SolrServers available
to handle this request:[http://127.0.0.1:32125, http://127.0.0.1:32129,
http://127.0.0.1:32112, http://127.0.0.1:32104, http://127.0.0.1:32097]
[junit4] > at
__randomizedtesting.SeedInfo.seed([79BF4887963062F6]:0)
[junit4] > at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:1056)
[junit4] > Caused by: org.apache.solr.client.solrj.SolrServerException:
No live SolrServers available to handle this request:[http://127.0.0.1:32125,
http://127.0.0.1:32129, http://127.0.0.1:32112, http://127.0.0.1:32104,
http://127.0.0.1:32097]
[junit4] > at
org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:322)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrServer.sendRequest(CloudSolrServer.java:880)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrServer.requestWithRetryOnStaleState(CloudSolrServer.java:658)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrServer.request(CloudSolrServer.java:601)
[junit4] > at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1548)
[junit4] > at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1569)
[junit4] > at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:1037)
[junit4] > Caused by:
org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: Could not
fully create collection: awholynewstresscollection_collection3_1
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:568)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:215)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:211)
[junit4] > at
org.apache.solr.client.solrj.impl.LBHttpSolrServer.doRequest(LBHttpSolrServer.java:343)
[junit4] > at
org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:304)
[junit4] > ... 6 moreThrowable #7:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=1598, name=Thread-464, state=RUNNABLE,
group=TGRP-CollectionsAPIDistributedZkTest]
[junit4] > Caused by: java.lang.RuntimeException:
org.apache.solr.client.solrj.SolrServerException: No live SolrServers available
to handle this request:[http://127.0.0.1:32125, http://127.0.0.1:32129,
http://127.0.0.1:32112, http://127.0.0.1:32104, http://127.0.0.1:32097]
[junit4] > at
__randomizedtesting.SeedInfo.seed([79BF4887963062F6]:0)
[junit4] > at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:1056)
[junit4] > Caused by: org.apache.solr.client.solrj.SolrServerException:
No live SolrServers available to handle this request:[http://127.0.0.1:32125,
http://127.0.0.1:32129, http://127.0.0.1:32112, http://127.0.0.1:32104,
http://127.0.0.1:32097]
[junit4] > at
org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:322)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrServer.sendRequest(CloudSolrServer.java:880)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrServer.requestWithRetryOnStaleState(CloudSolrServer.java:658)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrServer.request(CloudSolrServer.java:601)
[junit4] > at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1548)
[junit4] > at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1569)
[junit4] > at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:1037)
[junit4] > Caused by:
org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: Could not
fully create collection: awholynewstresscollection_collection4_1
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:568)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:215)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:211)
[junit4] > at
org.apache.solr.client.solrj.impl.LBHttpSolrServer.doRequest(LBHttpSolrServer.java:343)
[junit4] > at
org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:304)
[junit4] > ... 6 more
[junit4] 2> 733718 T1129 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionsAPIDistributedZkTest-79BF4887963062F6-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50):
{timestamp=FSTOrd41, a_i1=FSTOrd41, id=PostingsFormat(name=Memory doPackFST=
true), range_facet_l=FSTOrd41, intDefault=FSTOrd41, a_t=FSTOrd41,
text=OrdsLucene41(blocksize=128), multiDefault=PostingsFormat(name=Memory
doPackFST= false), other_tl1=FSTOrd41, _version_=FSTOrd41},
docValues:{timestamp=DocValuesFormat(name=Lucene410)},
sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=en_US,
timezone=Australia/Darwin
[junit4] 2> NOTE: FreeBSD 9.1-RELEASE-p3 amd64/Oracle Corporation 1.7.0_65
(64-bit)/cpus=16,threads=1,free=180865656,total=366477312
[junit4] 2> NOTE: All tests run in this JVM: [SuggesterTest,
ReplicationFactorTest, TestOrdValues, ClusterStateUpdateTest, TestNonNRTOpen,
TestCursorMarkWithoutUniqueKey, DocValuesMultiTest,
TestPHPSerializedResponseWriter, EchoParamsTest, UUIDFieldTest,
SolrTestCaseJ4Test, TestCoreDiscovery, TestCloudManagedSchemaConcurrent,
DocExpirationUpdateProcessorFactoryTest, SolrPluginUtilsTest,
TestDistribDocBasedVersion, TestSolrXmlPersistor, LoggingHandlerTest,
TestMergePolicyConfig, StatelessScriptUpdateProcessorFactoryTest,
IndexBasedSpellCheckerTest, RequestHandlersTest, TestRawResponseWriter,
SearchHandlerTest, OutputWriterTest, CollectionsAPIDistributedZkTest]
[junit4] Completed on J3 in 285.91s, 1 test, 1 error <<< FAILURES!
[...truncated 1112 lines...]
BUILD FAILED
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:531:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:472:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:61:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/extra-targets.xml:39:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build.xml:189:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/common-build.xml:496:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/lucene/common-build.xml:1360:
The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/lucene/common-build.xml:962:
There were test failures: 431 suites, 1778 tests, 1 error, 55 ignored (11
assumptions)
Total time: 204 minutes 27 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Sending artifact delta relative to Lucene-Solr-NightlyTests-5.x #632
Archived 5 artifacts
Archive block size is 32768
Received 0 blocks and 391693101 bytes
Compression is 0.0%
Took 1 min 10 sec
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
