Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-5.2/11/
All tests passed
Build Log:
[...truncated 12090 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/init-core-data-001
[junit4] 2> 1343166 T10984 oas.SolrTestCaseJ4.buildSSLConfig Randomized
ssl (false) and clientAuth (true)
[junit4] 2> 1343166 T10984
oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system
property: /u_mbs/zf
[junit4] 2> 1343170 T10984 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 2> 1343171 T10985 oasc.ZkTestServer$2$1.setClientPort client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1343171 T10985 oasc.ZkTestServer$ZKServerMain.runFromConfig
Starting server
[junit4] 2> 1343271 T10984 oasc.ZkTestServer.run start zk server on
port:46883
[junit4] 2> 1343271 T10984
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1343272 T10984 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 1343274 T10992 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@70b7f642
name:ZooKeeperConnection Watcher:127.0.0.1:46883 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1343275 T10984 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1343275 T10984 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1343275 T10984 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 1343278 T10984
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1343278 T10984 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 1343279 T10995 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@7d7c7c82
name:ZooKeeperConnection Watcher:127.0.0.1:46883/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1343280 T10984 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1343280 T10984 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1343280 T10984 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 1343282 T10984 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 1343284 T10984 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 1343285 T10984 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 1343287 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 1343287 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 1343290 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 1343290 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 1343292 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1343292 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1343294 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 1343294 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 1343296 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 1343296 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 1343298 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 1343298 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 1343300 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 1343300 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 1343302 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 1343302 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 1343304 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1343304 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1343306 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 1343306 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 1343307 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 1343308 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> 1343310 T10984
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1343310 T10984 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 1343311 T10998 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@585590d5
name:ZooKeeperConnection Watcher:127.0.0.1:46883 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1343312 T10984 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1343312 T10984 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1343312 T10984 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 1343314 T10984
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1343314 T10984 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 1343315 T11001 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@6bc24564
name:ZooKeeperConnection Watcher:127.0.0.1:46883/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1343315 T10984 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1343316 T10984 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1343316 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf2/solrconfig.xml
[junit4] 2> 1343317 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf2/solrconfig.xml
[junit4] 2> 1343319 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf2/schema.xml
[junit4] 2> 1343319 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf2/schema.xml
[junit4] 2> 1343321 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf2/enumsConfig.xml
[junit4] 2> 1343321 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf2/enumsConfig.xml
[junit4] 2> 1343323 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf2/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1343323 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf2/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1343325 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf2/stopwords.txt
[junit4] 2> 1343325 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf2/stopwords.txt
[junit4] 2> 1343326 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf2/protwords.txt
[junit4] 2> 1343327 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf2/protwords.txt
[junit4] 2> 1343328 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf2/currency.xml
[junit4] 2> 1343329 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf2/currency.xml
[junit4] 2> 1343330 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf2/open-exchange-rates.json
[junit4] 2> 1343330 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf2/open-exchange-rates.json
[junit4] 2> 1343332 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf2/mapping-ISOLatin1Accent.txt
[junit4] 2> 1343332 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf2/mapping-ISOLatin1Accent.txt
[junit4] 2> 1343334 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf2/old_synonyms.txt
[junit4] 2> 1343334 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf2/old_synonyms.txt
[junit4] 2> 1343336 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf2/synonyms.txt
[junit4] 2> 1343336 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf2/synonyms.txt
[junit4] 2> 1343338 T10984 oasc.AbstractZkTestCase.putConfig put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/core/src/test-files/solr/collection1/conf/elevate.xml
to /configs/conf2/elevate.xml
[junit4] 2> 1343338 T10984 oascc.SolrZkClient.makePath makePath:
/configs/conf2/elevate.xml
[junit4] 2> 1343630 T10984 oas.SolrTestCaseJ4.writeCoreProperties Writing
core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/control-001/cores/collection1
[junit4] 2> 1343632 T10984 oejs.Server.doStart jetty-9.2.10.v20150310
[junit4] 2> 1343633 T10984 oejsh.ContextHandler.doStart Started
o.e.j.s.ServletContextHandler@53e240b9{/u_mbs/zf,null,AVAILABLE}
[junit4] 2> 1343637 T10984 oejs.AbstractConnector.doStart Started
ServerConnector@70578524{HTTP/1.1}{127.0.0.1:43567}
[junit4] 2> 1343637 T10984 oejs.Server.doStart Started @1345072ms
[junit4] 2> 1343637 T10984 oascse.JettySolrRunner$1.lifeCycleStarted Jetty
properties:
{coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/control-001/cores, hostPort=43567, hostContext=/u_mbs/zf}
[junit4] 2> 1343638 T10984 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@7b3cb2c6
[junit4] 2> 1343638 T10984 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/control-001/'
[junit4] 2> 1343656 T10984 oasc.SolrXmlConfig.fromFile Loading container
configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/control-001/solr.xml
[junit4] 2> 1343679 T10984 oasc.CorePropertiesLocator.<init>
Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/control-001/cores
[junit4] 2> 1343679 T10984 oasc.CoreContainer.<init> New CoreContainer
712310242
[junit4] 2> 1343680 T10984 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/control-001/]
[junit4] 2> 1343680 T10984 oasc.CoreContainer.load loading shared library:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/control-001/lib
[junit4] 2> 1343680 T10984 oasc.SolrResourceLoader.addToClassLoader WARN
Can't find (or read) directory to add to classloader: lib (resolved as:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/control-001/lib).
[junit4] 2> 1343688 T10984 oashc.HttpShardHandlerFactory.init created with
socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost :
20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize :
2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy :
false,useRetries : false,
[junit4] 2> 1343689 T10984 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1343690 T10984 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1343690 T10984 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1343690 T10984 oasc.CoreContainer.load Node Name: 127.0.0.1
[junit4] 2> 1343691 T10984 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:46883/solr
[junit4] 2> 1343691 T10984 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 1343691 T10984
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1343692 T10984 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 1343693 T11015 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5c408dd2
name:ZooKeeperConnection Watcher:127.0.0.1:46883 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1343694 T10984 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1343695 T10984 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1343697 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oascc.ConnectionManager.waitForConnected Waiting for client to connect to
ZooKeeper
[junit4] 2> 1343698 T11018 n:127.0.0.1:43567_u_mbs%2Fzf
oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@4a1852c3
name:ZooKeeperConnection Watcher:127.0.0.1:46883/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1343698 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 1343700 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oascc.SolrZkClient.makePath makePath: /overseer/queue
[junit4] 2> 1343702 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work
[junit4] 2> 1343705 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oascc.SolrZkClient.makePath makePath: /overseer/collection-map-running
[junit4] 2> 1343708 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oascc.SolrZkClient.makePath makePath: /overseer/collection-map-completed
[junit4] 2> 1343710 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oascc.SolrZkClient.makePath makePath: /overseer/collection-map-failure
[junit4] 2> 1343712 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 1343714 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oascc.SolrZkClient.makePath makePath: /aliases.json
[junit4] 2> 1343716 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4] 2> 1343717 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.ZkController.createEphemeralLiveNode Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:43567_u_mbs%2Fzf
[junit4] 2> 1343718 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:43567_u_mbs%2Fzf
[junit4] 2> 1343720 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oascc.SolrZkClient.makePath makePath: /overseer_elect
[junit4] 2> 1343721 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4] 2> 1343723 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 1343724 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader
127.0.0.1:43567_u_mbs%2Fzf
[junit4] 2> 1343724 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4] 2> 1343726 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.Overseer.start Overseer
(id=93943302847528965-127.0.0.1:43567_u_mbs%2Fzf-n_0000000000) starting
[junit4] 2> 1343728 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oascc.SolrZkClient.makePath makePath: /overseer/queue-work
[junit4] 2> 1343735 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.OverseerAutoReplicaFailoverThread.<init> Starting
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=10000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 1343735 T11020 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.OverseerCollectionProcessor.run Process current queue of collection
creations
[junit4] 2> 1343735 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1343736 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4] 2> 1343739 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.CoreContainer.initializeAuthenticationPlugin No authentication plugin used.
[junit4] 2> 1343740 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.CoreContainer.intializeAuthorizationPlugin Security conf doesn't exist.
Skipping setup for authorization module.
[junit4] 2> 1343741 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.CorePropertiesLocator.discover Looking for core definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/control-001/cores
[junit4] 2> 1343742 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.CoreDescriptor.<init> CORE DESCRIPTOR:
{instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/control-001/cores/collection1,
collection=control_collection, schema=schema.xml, config=solrconfig.xml,
absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/control-001/cores/collection1/, shard=, dataDir=data/,
transient=false, loadOnStartup=true, coreNodeName=, name=collection1}
[junit4] 2> 1343743 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.CorePropertiesLocator.discoverUnder Found core collection1 in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/control-001/cores/collection1/
[junit4] 2> 1343743 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 1343744 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
c:control_collection x:collection1 oasc.ZkController.publish publishing
core=collection1 state=down collection=control_collection
[junit4] 2> 1343744 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
c:control_collection x:collection1 oasc.ZkController.publish numShards not
found on descriptor - reading it from system property
[junit4] 2> 1343745 T11018 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path
/overseer/queue state SyncConnected
[junit4] 2> 1343745 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 1343746 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "base_url":"http://127.0.0.1:43567/u_mbs/zf";,
[junit4] 2> "numShards":"1",
[junit4] 2> "node_name":"127.0.0.1:43567_u_mbs%2Fzf",
[junit4] 2> "roles":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"control_collection"} current state
version: 0
[junit4] 2> 1343746 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasco.ReplicaMutator.updateState Update state numShards=1 message={
[junit4] 2> "base_url":"http://127.0.0.1:43567/u_mbs/zf";,
[junit4] 2> "numShards":"1",
[junit4] 2> "node_name":"127.0.0.1:43567_u_mbs%2Fzf",
[junit4] 2> "roles":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"control_collection"}
[junit4] 2> 1343746 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasco.ClusterStateMutator.createCollection building a new cName:
control_collection
[junit4] 2> 1343747 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard1
[junit4] 2> 1343748 T11018 n:127.0.0.1:43567_u_mbs%2Fzf
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> 1344745 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for
collection1
[junit4] 2> 1344745 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.ZkController.createCollectionZkNode Check for collection
zkNode:control_collection
[junit4] 2> 1344746 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 1344746 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oascc.ZkStateReader.readConfigName Load collection config
from:/collections/control_collection
[junit4] 2> 1344747 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oascc.ZkStateReader.readConfigName path=/collections/control_collection
configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 1344747 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/control-001/cores/collection1/'
[junit4] 2> 1344762 T11022 n:127.0.0.1:43567_u_mbs%2Fzf oasc.Config.<init>
loaded config solrconfig.xml with version 0
[junit4] 2> 1344768 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 1344782 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0
[junit4] 2> 1344809 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1344810 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml
[junit4] 2> 1344817 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 1345047 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oass.OpenExchangeRatesOrgProvider.init Initialized with
rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1345054 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 1345056 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1345065 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oass.FileExchangeRateProvider.reload Reloading exchange rates from file
currency.xml
[junit4] 2> 1345068 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oass.FileExchangeRateProvider.reload Reloading exchange rates from file
currency.xml
[junit4] 2> 1345070 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 1345071 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1345071 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1345072 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 1345072 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1345072 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1345073 T11022 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration
from collection control_collection
[junit4] 2> 1345073 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1345073 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/control-001/cores/collection1/], dataDir=[null]
[junit4] 2> 1345073 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to
JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@158c156
[junit4] 2> 1345074 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasc.CachingDirectoryFactory.get return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/control-001/cores/collection1/data
[junit4] 2> 1345075 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasc.SolrCore.getNewIndexDir New index directory detected: old=null
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/control-001/cores/collection1/data/index/
[junit4] 2> 1345075 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasc.SolrCore.initIndex WARN [collection1] Solr index directory
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/control-001/cores/collection1/data/index' doesn't exist.
Creating new index...
[junit4] 2> 1345075 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasc.CachingDirectoryFactory.get return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/control-001/cores/collection1/data/index
[junit4] 2> 1345075 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=18, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=0.33203125, noCFSRatio=1.0]
[junit4] 2> 1345076 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@1a3978e1
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@332f093a;
maxCacheMB=0.025390625
maxMergeSizeMB=0.826171875)),segFN=segments_1,generation=1}
[junit4] 2> 1345076 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1345080 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"nodistrib"
[junit4] 2> 1345081 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"dedupe"
[junit4] 2> 1345081 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1345081 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"stored_sig"
[junit4] 2> 1345081 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1345081 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"distrib-dup-test-chain-explicit"
[junit4] 2> 1345082 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 1345082 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 1345082 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined
as default, creating implicit default
[junit4] 2> 1345085 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1345086 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1345087 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1345089 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1345092 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasc.RequestHandlers.initHandlersFromConfig Registered paths:
/admin/ping,/config,standard,/admin/mbeans,/admin/logging,/admin/luke,/admin/file,/schema,/update,/admin/plugins,/update/csv,/admin/segments,/admin/properties,/admin/threads,/admin/system,/update/json,/replication,/get,/update/json/docs
[junit4] 2> 1345093 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasc.SolrCore.initStatsCache Using default statsCache cache:
org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1345094 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasu.UpdateHandler.<init> Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1345094 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1345095 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 1345095 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1345096 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=3, maxMergeAtOnceExplicit=3, maxMergedSegmentMB=61.6533203125,
floorSegmentMB=1.2470703125, forceMergeDeletesPctAllowed=4.5501836644801195,
segmentsPerTier=15.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6703114503366376
[junit4] 2> 1345096 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@1a3978e1
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@332f093a;
maxCacheMB=0.025390625
maxMergeSizeMB=0.826171875)),segFN=segments_1,generation=1}
[junit4] 2> 1345097 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1345097 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oass.SolrIndexSearcher.<init> Opening Searcher@26a8671c[collection1] main
[junit4] 2> 1345097 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oascc.ZkStateReader.readConfigName Load collection config
from:/collections/control_collection
[junit4] 2> 1345098 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oascc.ZkStateReader.readConfigName path=/collections/control_collection
configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 1345098 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for
the RestManager with znodeBase: /configs/conf1
[junit4] 2> 1345099 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 1345099 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 1345099 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasr.ManagedResourceStorage.load Reading _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1345099 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 1345099 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1345100 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 1345100 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 1345101 T11023 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasc.SolrCore.registerSearcher [collection1] Registered new searcher
Searcher@26a8671c[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1345101 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasu.UpdateLog.seedBucketsWithHighestVersion Looking up max value of version
field to seed version buckets
[junit4] 2> 1345101 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasu.VersionInfo.getMaxVersionFromIndex Refreshing highest value of _version_
for 65536 version buckets from index
[junit4] 2> 1345101 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasu.VersionInfo.getMaxVersionFromIndex No terms found for _version_, cannot
seed version bucket highest value from index
[junit4] 2> 1345101 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasu.UpdateLog.seedBucketsWithHighestVersion Could not find max version in
index or recent updates, using new clock 1503092847582117888
[junit4] 2> 1345103 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasu.UpdateLog.seedBucketsWithHighestVersion Took 2 ms to seed version buckets
with highest version 1503092847582117888
[junit4] 2> 1345103 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasc.ZkController.getConfDirListeners watch zkdir /configs/conf1
[junit4] 2> 1345104 T11022 n:127.0.0.1:43567_u_mbs%2Fzf x:collection1
oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 1345105 T11026 n:127.0.0.1:43567_u_mbs%2Fzf
c:control_collection s:shard1 x:collection1 oasc.ZkController.register Register
replica - core:collection1 address:http://127.0.0.1:43567/u_mbs/zf
collection:control_collection shard:shard1
[junit4] 2> 1345105 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oass.SolrDispatchFilter.init
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2
[junit4] 2> 1345105 T10984 n:127.0.0.1:43567_u_mbs%2Fzf
oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 1345106 T11026 n:127.0.0.1:43567_u_mbs%2Fzf
c:control_collection s:shard1 x:collection1 oascc.SolrZkClient.makePath
makePath: /collections/control_collection/leader_elect/shard1/election
[junit4] 2> 1345107 T10984
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1345107 T10984 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 1345109 T11029 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@48c65099
name:ZooKeeperConnection Watcher:127.0.0.1:46883/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1345109 T10984 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1345109 T10984 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1345110 T10984
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1345110 T11026 n:127.0.0.1:43567_u_mbs%2Fzf
c:control_collection s:shard1 x:collection1
oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for
shard shard1
[junit4] 2> 1345111 T11018 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path
/overseer/queue state SyncConnected
[junit4] 2> 1345112 T11026 n:127.0.0.1:43567_u_mbs%2Fzf
c:control_collection s:shard1 x:collection1
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 1345112 T11026 n:127.0.0.1:43567_u_mbs%2Fzf
c:control_collection s:shard1 x:collection1
oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try
and sync
[junit4] 2> ASYNC NEW_CORE C2999 name=collection1
org.apache.solr.core.SolrCore@1ab95037
url=http://127.0.0.1:43567/u_mbs/zf/collection1 node=127.0.0.1:43567_u_mbs%2Fzf
C2999_STATE=coll:control_collection core:collection1
props:{base_url=http://127.0.0.1:43567/u_mbs/zf,
node_name=127.0.0.1:43567_u_mbs%2Fzf, core=collection1, state=down}
[junit4] 2> 1345112 T11026 n:127.0.0.1:43567_u_mbs%2Fzf
c:control_collection s:shard1 x:collection1 C2999 oasc.SyncStrategy.sync Sync
replicas to http://127.0.0.1:43567/u_mbs/zf/collection1/
[junit4] 2> 1345112 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection"} current state
version: 1
[junit4] 2> 1345112 T11026 n:127.0.0.1:43567_u_mbs%2Fzf
c:control_collection s:shard1 x:collection1 C2999
oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4] 2> 1345113 T11026 n:127.0.0.1:43567_u_mbs%2Fzf
c:control_collection s:shard1 x:collection1 C2999 oasc.SyncStrategy.syncToMe
http://127.0.0.1:43567/u_mbs/zf/collection1/ has no replicas
[junit4] 2> 1345113 T10984 oasc.ChaosMonkey.monkeyLog monkey: init -
expire sessions:false cause connection loss:false
[junit4] 2> 1345113 T11026 n:127.0.0.1:43567_u_mbs%2Fzf
c:control_collection s:shard1 x:collection1
oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader:
http://127.0.0.1:43567/u_mbs/zf/collection1/ shard1
[junit4] 2> 1345113 T10984 oasc.AbstractFullDistribZkTestBase.createJettys
Creating collection1 with stateFormat=2
[junit4] 2> 1345114 T11026 n:127.0.0.1:43567_u_mbs%2Fzf
c:control_collection s:shard1 x:collection1 oascc.SolrZkClient.makePath
makePath: /collections/control_collection/leaders/shard1
[junit4] 2> 1345114 T10984
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1345114 T10984 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 1345116 T11032 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@3a43082c
name:ZooKeeperConnection Watcher:127.0.0.1:46883/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1345116 T10984 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1345116 T10984 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1345118 T11018 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path
/overseer/queue state SyncConnected
[junit4] 2> 1345119 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 2, message = {
[junit4] 2> "operation":"create",
[junit4] 2> "name":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "stateFormat":"2"} current state version: 1
[junit4] 2> 1345119 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasco.ClusterStateMutator.createCollection building a new cName: collection1
[junit4] 2> 1345119 T11029 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> 1345124 T11018 n:127.0.0.1:43567_u_mbs%2Fzf
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> 1345127 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "base_url":"http://127.0.0.1:43567/u_mbs/zf";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 2
[junit4] 2> 1345128 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasco.ZkStateWriter.writePendingUpdates going to create_collection
/collections/collection1/state.json
[junit4] 2> 1345129 T11029 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> 1345129 T11018 n:127.0.0.1:43567_u_mbs%2Fzf
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> 1345132 T11018 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path
/overseer/queue state SyncConnected
[junit4] 2> 1345132 T11029 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> 1345133 T11018 n:127.0.0.1:43567_u_mbs%2Fzf
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> 1345169 T11026 n:127.0.0.1:43567_u_mbs%2Fzf
c:control_collection s:shard1 x:collection1 oasc.ZkController.register We are
http://127.0.0.1:43567/u_mbs/zf/collection1/ and leader is
http://127.0.0.1:43567/u_mbs/zf/collection1/
[junit4] 2> 1345169 T11026 n:127.0.0.1:43567_u_mbs%2Fzf
c:control_collection s:shard1 x:collection1 oasc.ZkController.register No
LogReplay needed for core=collection1 baseURL=http://127.0.0.1:43567/u_mbs/zf
[junit4] 2> 1345169 T11026 n:127.0.0.1:43567_u_mbs%2Fzf
c:control_collection s:shard1 x:collection1 oasc.ZkController.checkRecovery I
am the leader, no recovery necessary
[junit4] 2> 1345169 T11026 n:127.0.0.1:43567_u_mbs%2Fzf
c:control_collection s:shard1 x:collection1 oasc.ZkController.publish
publishing core=collection1 state=active collection=control_collection
[junit4] 2> 1345169 T11026 n:127.0.0.1:43567_u_mbs%2Fzf
c:control_collection s:shard1 x:collection1 oasc.ZkController.publish numShards
not found on descriptor - reading it from system property
[junit4] 2> 1345170 T11018 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path
/overseer/queue state SyncConnected
[junit4] 2> 1345171 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "base_url":"http://127.0.0.1:43567/u_mbs/zf";,
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:43567_u_mbs%2Fzf",
[junit4] 2> "roles":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"control_collection"} current state
version: 4
[junit4] 2> 1345172 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasco.ReplicaMutator.updateState Update state numShards=2 message={
[junit4] 2> "base_url":"http://127.0.0.1:43567/u_mbs/zf";,
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:43567_u_mbs%2Fzf",
[junit4] 2> "roles":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"control_collection"}
[junit4] 2> 1345275 T11029 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> 1345275 T11018 n:127.0.0.1:43567_u_mbs%2Fzf
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> 1345426 T10984 oas.SolrTestCaseJ4.writeCoreProperties Writing
core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-1-001/cores/collection1
[junit4] 2> 1345427 T10984 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-1-001
[junit4] 2> 1345428 T10984 oejs.Server.doStart jetty-9.2.10.v20150310
[junit4] 2> 1345429 T10984 oejsh.ContextHandler.doStart Started
o.e.j.s.ServletContextHandler@7c574019{/u_mbs/zf,null,AVAILABLE}
[junit4] 2> 1345430 T10984 oejs.AbstractConnector.doStart Started
ServerConnector@7ea04ad{HTTP/1.1}{127.0.0.1:36903}
[junit4] 2> 1345430 T10984 oejs.Server.doStart Started @1346865ms
[junit4] 2> 1345431 T10984 oascse.JettySolrRunner$1.lifeCycleStarted Jetty
properties: {solrconfig=solrconfig.xml, hostContext=/u_mbs/zf, hostPort=36903,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-1-001/cores}
[junit4] 2> 1345431 T10984 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@7b3cb2c6
[junit4] 2> 1345431 T10984 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-1-001/'
[junit4] 2> 1345446 T10984 oasc.SolrXmlConfig.fromFile Loading container
configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-1-001/solr.xml
[junit4] 2> 1345459 T10984 oasc.CorePropertiesLocator.<init>
Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-1-001/cores
[junit4] 2> 1345460 T10984 oasc.CoreContainer.<init> New CoreContainer
538700096
[junit4] 2> 1345460 T10984 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-1-001/]
[junit4] 2> 1345460 T10984 oasc.CoreContainer.load loading shared library:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-1-001/lib
[junit4] 2> 1345461 T10984 oasc.SolrResourceLoader.addToClassLoader WARN
Can't find (or read) directory to add to classloader: lib (resolved as:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-1-001/lib).
[junit4] 2> 1345468 T10984 oashc.HttpShardHandlerFactory.init created with
socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost :
20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize :
2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy :
false,useRetries : false,
[junit4] 2> 1345470 T10984 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1345470 T10984 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1345470 T10984 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1345471 T10984 oasc.CoreContainer.load Node Name: 127.0.0.1
[junit4] 2> 1345471 T10984 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:46883/solr
[junit4] 2> 1345471 T10984 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 1345471 T10984
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1345472 T10984 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 1345474 T11046 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@55cb72e3
name:ZooKeeperConnection Watcher:127.0.0.1:46883 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1345474 T10984 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1345475 T10984 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1345476 T10984 n:127.0.0.1:36903_u_mbs%2Fzf
oascc.ConnectionManager.waitForConnected Waiting for client to connect to
ZooKeeper
[junit4] 2> 1345477 T11049 n:127.0.0.1:36903_u_mbs%2Fzf
oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@4f9ef007
name:ZooKeeperConnection Watcher:127.0.0.1:46883/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1345478 T10984 n:127.0.0.1:36903_u_mbs%2Fzf
oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 1345482 T10984 n:127.0.0.1:36903_u_mbs%2Fzf
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1346488 T10984 n:127.0.0.1:36903_u_mbs%2Fzf
oasc.ZkController.createEphemeralLiveNode Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:36903_u_mbs%2Fzf
[junit4] 2> 1346489 T10984 n:127.0.0.1:36903_u_mbs%2Fzf
oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:36903_u_mbs%2Fzf
[junit4] 2> 1346492 T10984 n:127.0.0.1:36903_u_mbs%2Fzf
oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 1346494 T10984 n:127.0.0.1:36903_u_mbs%2Fzf
oasc.CoreContainer.initializeAuthenticationPlugin No authentication plugin used.
[junit4] 2> 1346495 T10984 n:127.0.0.1:36903_u_mbs%2Fzf
oasc.CoreContainer.intializeAuthorizationPlugin Security conf doesn't exist.
Skipping setup for authorization module.
[junit4] 2> 1346495 T10984 n:127.0.0.1:36903_u_mbs%2Fzf
oasc.CorePropertiesLocator.discover Looking for core definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-1-001/cores
[junit4] 2> 1346496 T10984 n:127.0.0.1:36903_u_mbs%2Fzf
oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {dataDir=data/, name=collection1,
schema=schema.xml, shard=,
absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-1-001/cores/collection1/, transient=false,
collection=collection1, loadOnStartup=true,
instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-1-001/cores/collection1, coreNodeName=,
config=solrconfig.xml}
[junit4] 2> 1346497 T10984 n:127.0.0.1:36903_u_mbs%2Fzf
oasc.CorePropertiesLocator.discoverUnder Found core collection1 in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-1-001/cores/collection1/
[junit4] 2> 1346497 T10984 n:127.0.0.1:36903_u_mbs%2Fzf
oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 1346500 T11050 n:127.0.0.1:36903_u_mbs%2Fzf c:collection1
x:collection1 oasc.ZkController.publish publishing core=collection1 state=down
collection=collection1
[junit4] 2> 1346500 T11050 n:127.0.0.1:36903_u_mbs%2Fzf c:collection1
x:collection1 oasc.ZkController.publish numShards not found on descriptor -
reading it from system property
[junit4] 2> 1346501 T11018 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path
/overseer/queue state SyncConnected
[junit4] 2> 1346502 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oasc.ZkController.preRegister Registering watch for external collection
collection1
[junit4] 2> 1346502 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oascc.ZkStateReader.addZkWatch addZkWatch collection1
[junit4] 2> 1346502 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "base_url":"http://127.0.0.1:36903/u_mbs/zf";,
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:36903_u_mbs%2Fzf",
[junit4] 2> "roles":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"collection1"} current state version: 5
[junit4] 2> 1346502 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oascc.ZkStateReader.addZkWatch Updating collection state at
/collections/collection1/state.json from ZooKeeper...
[junit4] 2> 1346503 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasco.ReplicaMutator.updateState Update state numShards=2 message={
[junit4] 2> "base_url":"http://127.0.0.1:36903/u_mbs/zf";,
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:36903_u_mbs%2Fzf",
[junit4] 2> "roles":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"collection1"}
[junit4] 2> 1346503 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasco.ReplicaMutator.updateState Collection already exists with numShards=2
[junit4] 2> 1346503 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard2
[junit4] 2> 1346504 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to
ver 0
[junit4] 2> 1346504 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 1346606 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasco.ZkStateWriter.writePendingUpdates going to update_collection
/collections/collection1/state.json version: 0
[junit4] 2> 1346607 T11049 n:127.0.0.1:36903_u_mbs%2Fzf
oascc.ZkStateReader$7.process A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json for collection collection1 has
occurred - updating... (live nodes size: 2)
[junit4] 2> 1346608 T11049 n:127.0.0.1:36903_u_mbs%2Fzf
oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to
ver 1
[junit4] 2> 1347504 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for
collection1
[junit4] 2> 1347505 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4] 2> 1347505 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 1347505 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oascc.ZkStateReader.readConfigName Load collection config
from:/collections/collection1
[junit4] 2> 1347506 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oascc.ZkStateReader.readConfigName path=/collections/collection1
configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 1347506 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-1-001/cores/collection1/'
[junit4] 2> 1347523 T11050 n:127.0.0.1:36903_u_mbs%2Fzf oasc.Config.<init>
loaded config solrconfig.xml with version 0
[junit4] 2> 1347530 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 1347544 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0
[junit4] 2> 1347573 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1347574 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml
[junit4] 2> 1347582 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 1347854 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oass.OpenExchangeRatesOrgProvider.init Initialized with
rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1347862 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 1347864 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1347874 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oass.FileExchangeRateProvider.reload Reloading exchange rates from file
currency.xml
[junit4] 2> 1347877 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oass.FileExchangeRateProvider.reload Reloading exchange rates from file
currency.xml
[junit4] 2> 1347880 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 1347881 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1347881 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1347881 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 1347882 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1347882 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1347882 T11050 n:127.0.0.1:36903_u_mbs%2Fzf
oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration
from collection collection1
[junit4] 2> 1347882 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1347883 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-1-001/cores/collection1/], dataDir=[null]
[junit4] 2> 1347883 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to
JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@158c156
[junit4] 2> 1347884 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasc.CachingDirectoryFactory.get return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-1-001/cores/collection1/data
[junit4] 2> 1347884 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasc.SolrCore.getNewIndexDir New index directory detected: old=null
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-1-001/cores/collection1/data/index/
[junit4] 2> 1347885 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasc.SolrCore.initIndex WARN [collection1] Solr index directory
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-1-001/cores/collection1/data/index' doesn't exist.
Creating new index...
[junit4] 2> 1347885 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasc.CachingDirectoryFactory.get return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-1-001/cores/collection1/data/index
[junit4] 2> 1347885 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=18, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=0.33203125, noCFSRatio=1.0]
[junit4] 2> 1347886 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@39413843
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@68d4d412;
maxCacheMB=0.025390625
maxMergeSizeMB=0.826171875)),segFN=segments_1,generation=1}
[junit4] 2> 1347886 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1347891 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"nodistrib"
[junit4] 2> 1347891 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"dedupe"
[junit4] 2> 1347891 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1347892 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"stored_sig"
[junit4] 2> 1347892 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1347892 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"distrib-dup-test-chain-explicit"
[junit4] 2> 1347892 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 1347893 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 1347893 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined
as default, creating implicit default
[junit4] 2> 1347895 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1347897 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1347898 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1347901 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1347908 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasc.RequestHandlers.initHandlersFromConfig Registered paths:
/admin/ping,/config,standard,/admin/mbeans,/admin/logging,/admin/luke,/admin/file,/schema,/update,/admin/plugins,/update/csv,/admin/segments,/admin/properties,/admin/threads,/admin/system,/update/json,/replication,/get,/update/json/docs
[junit4] 2> 1347909 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasc.SolrCore.initStatsCache Using default statsCache cache:
org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1347910 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasu.UpdateHandler.<init> Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1347910 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1347911 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 1347911 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1347913 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=3, maxMergeAtOnceExplicit=3, maxMergedSegmentMB=61.6533203125,
floorSegmentMB=1.2470703125, forceMergeDeletesPctAllowed=4.5501836644801195,
segmentsPerTier=15.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6703114503366376
[junit4] 2> 1347913 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@39413843
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@68d4d412;
maxCacheMB=0.025390625
maxMergeSizeMB=0.826171875)),segFN=segments_1,generation=1}
[junit4] 2> 1347913 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1347913 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oass.SolrIndexSearcher.<init> Opening Searcher@28601707[collection1] main
[junit4] 2> 1347914 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oascc.ZkStateReader.readConfigName Load collection config
from:/collections/collection1
[junit4] 2> 1347915 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oascc.ZkStateReader.readConfigName path=/collections/collection1
configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 1347915 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for
the RestManager with znodeBase: /configs/conf1
[junit4] 2> 1347915 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 1347915 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 1347916 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasr.ManagedResourceStorage.load Reading _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1347916 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 1347916 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1347916 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 1347917 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 1347917 T11051 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasc.SolrCore.registerSearcher [collection1] Registered new searcher
Searcher@28601707[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1347918 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasu.UpdateLog.seedBucketsWithHighestVersion Looking up max value of version
field to seed version buckets
[junit4] 2> 1347918 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasu.VersionInfo.getMaxVersionFromIndex Refreshing highest value of _version_
for 65536 version buckets from index
[junit4] 2> 1347918 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasu.VersionInfo.getMaxVersionFromIndex No terms found for _version_, cannot
seed version bucket highest value from index
[junit4] 2> 1347918 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasu.UpdateLog.seedBucketsWithHighestVersion Could not find max version in
index or recent updates, using new clock 1503092850535956480
[junit4] 2> 1347920 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasu.UpdateLog.seedBucketsWithHighestVersion Took 2 ms to seed version buckets
with highest version 1503092850535956480
[junit4] 2> 1347920 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasc.ZkController.getConfDirListeners watch zkdir /configs/conf1
[junit4] 2> 1347921 T11050 n:127.0.0.1:36903_u_mbs%2Fzf x:collection1
oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 1347922 T11054 n:127.0.0.1:36903_u_mbs%2Fzf c:collection1
s:shard2 x:collection1 oasc.ZkController.register Register replica -
core:collection1 address:http://127.0.0.1:36903/u_mbs/zf collection:collection1
shard:shard2
[junit4] 2> 1347922 T10984 n:127.0.0.1:36903_u_mbs%2Fzf
oass.SolrDispatchFilter.init
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2
[junit4] 2> 1347922 T10984 n:127.0.0.1:36903_u_mbs%2Fzf
oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 1347923 T11054 n:127.0.0.1:36903_u_mbs%2Fzf c:collection1
s:shard2 x:collection1 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leader_elect/shard2/election
[junit4] 2> 1347928 T11054 n:127.0.0.1:36903_u_mbs%2Fzf c:collection1
s:shard2 x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess Running
the leader process for shard shard2
[junit4] 2> 1347929 T11018 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path
/overseer/queue state SyncConnected
[junit4] 2> 1347929 T11054 n:127.0.0.1:36903_u_mbs%2Fzf c:collection1
s:shard2 x:collection1 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp
Enough replicas found to continue.
[junit4] 2> 1347930 T11054 n:127.0.0.1:36903_u_mbs%2Fzf c:collection1
s:shard2 x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess I may
be the new leader - try and sync
[junit4] 2> ASYNC NEW_CORE C3000 name=collection1
org.apache.solr.core.SolrCore@2952508d
url=http://127.0.0.1:36903/u_mbs/zf/collection1 node=127.0.0.1:36903_u_mbs%2Fzf
C3000_STATE=coll:collection1 core:collection1
props:{base_url=http://127.0.0.1:36903/u_mbs/zf,
node_name=127.0.0.1:36903_u_mbs%2Fzf, core=collection1, state=down}
[junit4] 2> 1347930 T11054 n:127.0.0.1:36903_u_mbs%2Fzf c:collection1
s:shard2 x:collection1 C3000 oasc.SyncStrategy.sync Sync replicas to
http://127.0.0.1:36903/u_mbs/zf/collection1/
[junit4] 2> 1347930 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"collection1"} current state version: 5
[junit4] 2> 1347931 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasco.ZkStateWriter.writePendingUpdates going to update_collection
/collections/collection1/state.json version: 1
[junit4] 2> 1347931 T11049 n:127.0.0.1:36903_u_mbs%2Fzf
oascc.ZkStateReader$7.process A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json for collection collection1 has
occurred - updating... (live nodes size: 2)
[junit4] 2> 1347932 T11049 n:127.0.0.1:36903_u_mbs%2Fzf
oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to
ver 2
[junit4] 2> 1347930 T11054 n:127.0.0.1:36903_u_mbs%2Fzf c:collection1
s:shard2 x:collection1 C3000 oasc.SyncStrategy.syncReplicas Sync Success - now
sync replicas to me
[junit4] 2> 1347933 T11054 n:127.0.0.1:36903_u_mbs%2Fzf c:collection1
s:shard2 x:collection1 C3000 oasc.SyncStrategy.syncToMe
http://127.0.0.1:36903/u_mbs/zf/collection1/ has no replicas
[junit4] 2> 1347934 T11054 n:127.0.0.1:36903_u_mbs%2Fzf c:collection1
s:shard2 x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess I am
the new leader: http://127.0.0.1:36903/u_mbs/zf/collection1/ shard2
[junit4] 2> 1347934 T11054 n:127.0.0.1:36903_u_mbs%2Fzf c:collection1
s:shard2 x:collection1 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leaders/shard2
[junit4] 2> 1347937 T11018 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path
/overseer/queue state SyncConnected
[junit4] 2> 1347938 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "base_url":"http://127.0.0.1:36903/u_mbs/zf";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 5
[junit4] 2> 1347938 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasco.ZkStateWriter.writePendingUpdates going to update_collection
/collections/collection1/state.json version: 2
[junit4] 2> 1347939 T11049 n:127.0.0.1:36903_u_mbs%2Fzf
oascc.ZkStateReader$7.process A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json for collection collection1 has
occurred - updating... (live nodes size: 2)
[junit4] 2> 1347939 T11049 n:127.0.0.1:36903_u_mbs%2Fzf
oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to
ver 3
[junit4] 2> 1347941 T11054 n:127.0.0.1:36903_u_mbs%2Fzf c:collection1
s:shard2 x:collection1 oasc.ZkController.register We are
http://127.0.0.1:36903/u_mbs/zf/collection1/ and leader is
http://127.0.0.1:36903/u_mbs/zf/collection1/
[junit4] 2> 1347941 T11054 n:127.0.0.1:36903_u_mbs%2Fzf c:collection1
s:shard2 x:collection1 oasc.ZkController.register No LogReplay needed for
core=collection1 baseURL=http://127.0.0.1:36903/u_mbs/zf
[junit4] 2> 1347941 T11054 n:127.0.0.1:36903_u_mbs%2Fzf c:collection1
s:shard2 x:collection1 oasc.ZkController.checkRecovery I am the leader, no
recovery necessary
[junit4] 2> 1347941 T11054 n:127.0.0.1:36903_u_mbs%2Fzf c:collection1
s:shard2 x:collection1 oasc.ZkController.publish publishing core=collection1
state=active collection=collection1
[junit4] 2> 1347941 T11054 n:127.0.0.1:36903_u_mbs%2Fzf c:collection1
s:shard2 x:collection1 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 1347942 T11018 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path
/overseer/queue state SyncConnected
[junit4] 2> 1347943 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "base_url":"http://127.0.0.1:36903/u_mbs/zf";,
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:36903_u_mbs%2Fzf",
[junit4] 2> "roles":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard2",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"collection1"} current state version: 5
[junit4] 2> 1347944 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasco.ReplicaMutator.updateState Update state numShards=2 message={
[junit4] 2> "base_url":"http://127.0.0.1:36903/u_mbs/zf";,
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:36903_u_mbs%2Fzf",
[junit4] 2> "roles":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard2",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"collection1"}
[junit4] 2> 1347945 T11019 n:127.0.0.1:43567_u_mbs%2Fzf
oasco.ZkStateWriter.writePendingUpdates going to update_collection
/collections/collection1/state.json version: 3
[junit4] 2> 1347945 T11049 n:127.0.0.1:36903_u_mbs%2Fzf
oascc.ZkStateReader$7.process A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json for collection collection1 has
occurred - updating... (live nodes size: 2)
[junit4] 2> 1347946 T11054 n:127.0.0.1:36903_u_mbs%2Fzf c:collection1
s:shard2 x:collection1 oascc.ZkStateReader.updateWatchedCollection Updating
data for collection1 to ver 4
[junit4] 2> 1347947 T11049 n:127.0.0.1:36903_u_mbs%2Fzf
oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to
ver 4
[junit4] 2> 1348217 T10984 oas.SolrTestCaseJ4.writeCoreProperties Writing
core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-2-001/cores/collection1
[junit4] 2> 1348218 T10984 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-2-001
[junit4] 2> 1348219 T10984 oejs.Server.doStart jetty-9.2.10.v20150310
[junit4] 2> 1348222 T10984 oejsh.ContextHandler.doStart Started
o.e.j.s.ServletContextHandler@206cf1fc{/u_mbs/zf,null,AVAILABLE}
[junit4] 2> 1348222 T10984 oejs.AbstractConnector.doStart Started
ServerConnector@424ec98e{HTTP/1.1}{127.0.0.1:38125}
[junit4] 2> 1348222 T10984 oejs.Server.doStart Started @1349657ms
[junit4] 2> 1348223 T10984 oascse.JettySolrRunner$1.lifeCycleStarted Jetty
properties:
{coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-2-001/cores, solrconfig=solrconfig.xml,
hostContext=/u_mbs/zf, hostPort=38125}
[junit4] 2> 1348223 T10984 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@7b3cb2c6
[junit4] 2> 1348223 T10984 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-2-001/'
[junit4] 2> 1348238 T10984 oasc.SolrXmlConfig.fromFile Loading container
configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-2-001/solr.xml
[junit4] 2> 1348251 T10984 oasc.CorePropertiesLocator.<init>
Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-2-001/cores
[junit4] 2> 1348252 T10984 oasc.CoreContainer.<init> New CoreContainer
1768574986
[junit4] 2> 1348252 T10984 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-2-001/]
[junit4] 2> 1348252 T10984 oasc.CoreContainer.load loading shared library:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-2-001/lib
[junit4] 2> 1348252 T10984 oasc.SolrResourceLoader.addToClassLoader WARN
Can't find (or read) directory to add to classloader: lib (resolved as:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest
8EE5315ABA299BC9-001/shard-2-001/lib).
[junit4] 2> 1348260 T10984 oashc.HttpShardHandlerFactory.init created with
socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost :
20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize :
2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy :
false,useRetries : false,
[junit4] 2> 1348262 T10984 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1348262 T10984 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[j
[...truncated too long message...]
e.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
[junit4] 2> at
org.eclipse.jetty.servlets.UserAgentFilter.doFilter(UserAgentFilter.java:83)
[junit4] 2> at
org.eclipse.jetty.servlets.GzipFilter.doFilter(GzipFilter.java:364)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:585)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97)
[junit4] 2> at
org.eclipse.jetty.server.Server.handle(Server.java:497)
[junit4] 2> at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:310)
[junit4] 2> at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:257)
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:540)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> NOTE: All tests run in this JVM: [SearchHandlerTest,
TestMacros, StatsComponentTest, AutoCommitTest, SSLMigrationTest,
TestSortingResponseWriter, TestSystemIdResolver, PrimUtilsTest,
BlockDirectoryTest, TestTrackingShardHandlerFactory,
TestBlendedInfixSuggestions, DistributedFacetPivotSmallAdvancedTest,
OverseerCollectionProcessorTest, ResponseLogComponentTest, DeleteShardTest,
QueryEqualityTest, PolyFieldTest, HttpPartitionTest, TestSolrQueryParser,
TestFastOutputStream, RecoveryZkTest, HdfsBasicDistributedZkTest,
FileBasedSpellCheckerTest, TestGroupingSearch, BadIndexSchemaTest,
DistributedVersionInfoTest, TestFieldCollectionResource,
PathHierarchyTokenizerFactoryTest, TestSort, SoftAutoCommitTest,
TestMissingGroups, TestQueryUtils, TestPerFieldSimilarity,
TestClusterStateMutator, CoreAdminRequestStatusTest, SaslZkACLProviderTest,
TestSolrConfigHandlerCloud, TestQueryTypes,
HdfsCollectionsAPIDistributedZkTest, XsltUpdateRequestHandlerTest,
CloudMLTQParserTest, TestRestoreCore, TestSolrConfigHandlerConcurrent,
TestSolrConfigHandler, RegexBoostProcessorTest, TestRecovery,
TestDistributedStatsComponentCardinality, TermVectorComponentDistributedTest,
TestQuerySenderNoQuery, TestLuceneMatchVersion,
OpenExchangeRatesOrgProviderTest, TestConfigOverlay, TestAddFieldRealTimeGet,
LoggingHandlerTest, TestZkChroot, TestAuthenticationFramework,
DirectSolrSpellCheckerTest, TestUtils, TestCollectionAPI,
XmlUpdateRequestHandlerTest, SolrCoreCheckLockOnStartupTest,
SegmentsInfoRequestHandlerTest, TestCloudPivotFacet, AnalysisErrorHandlingTest,
NumericFieldsTest, MoreLikeThisHandlerTest, FullSolrCloudDistribCmdsTest,
HdfsBasicDistributedZk2Test, TestPseudoReturnFields, TestBulkSchemaConcurrent,
TestBinaryResponseWriter, ZkStateWriterTest, TestRecoveryHdfs, SuggesterTest,
TestFieldTypeResource, ChangedSchemaMergeTest, TestManagedSchemaFieldResource,
HdfsNNFailoverTest, ChaosMonkeySafeLeaderTest, CollectionsAPIDistributedZkTest]
[junit4] 2> 8329895 T11109 n:127.0.0.1:39787_u_mbs%2Fzf
oasc.SolrException.log ERROR
null:org.apache.zookeeper.KeeperException$ConnectionLossException:
KeeperErrorCode = ConnectionLoss for
/overseer/collection-queue-work/qnr-0000000024
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:99)
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at
org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1155)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:345)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:342)
[junit4] 2> at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:61)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:342)
[junit4] 2> at
org.apache.solr.cloud.DistributedQueue.offer(DistributedQueue.java:412)
[junit4] 2> at
org.apache.solr.handler.admin.CollectionsHandler.handleResponse(CollectionsHandler.java:224)
[junit4] 2> at
org.apache.solr.handler.admin.CollectionsHandler.handleRequestBody(CollectionsHandler.java:168)
[junit4] 2> at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:143)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:646)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:417)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:227)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:196)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
[junit4] 2> at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:105)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
[junit4] 2> at
org.eclipse.jetty.servlets.UserAgentFilter.doFilter(UserAgentFilter.java:83)
[junit4] 2> at
org.eclipse.jetty.servlets.GzipFilter.doFilter(GzipFilter.java:364)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:585)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97)
[junit4] 2> at
org.eclipse.jetty.server.Server.handle(Server.java:497)
[junit4] 2> at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:310)
[junit4] 2> at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:257)
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:540)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] ERROR 0.00s J2 | CollectionsAPIDistributedZkTest (suite) <<<
[junit4] > Throwable #1: java.lang.OutOfMemoryError: Java heap space
[junit4] Completed [497/497] on J2 in 42864.90s, 1 test, 1 error <<<
FAILURES!
[...truncated 11 lines...]
[junit4] JVM J2: stdout was not empty, see:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build/solr-core/test/temp/junit4-J2-20150604_191457_281.sysout
[junit4] >>> JVM J2: stdout (verbatim) ----
[junit4] java.lang.OutOfMemoryError: Java heap space
[junit4] Dumping heap to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/heapdumps/java_pid28391.hprof
...
[junit4] Heap dump file created [660913182 bytes in 5.704 secs]
[junit4] <<< JVM J2: EOF ----
[...truncated 10 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/build.xml:543:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/build.xml:484:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/build.xml:61:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/extra-targets.xml:39:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/build.xml:229:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/solr/common-build.xml:511:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/lucene/common-build.xml:1436:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.2/lucene/common-build.xml:991:
There were test failures: 497 suites, 1974 tests, 1 suite-level error, 52
ignored (10 assumptions)
Total time: 860 minutes 41 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Sending artifact delta relative to Lucene-Solr-NightlyTests-5.2 #3
Archived 5 artifacts
Archive block size is 32768
Received 0 blocks and 1295455181 bytes
Compression is 0.0%
Took 3 min 47 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]
