Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-MacOSX/1833/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC

1 tests failed.
REGRESSION:  org.apache.solr.cloud.ChaosMonkeySafeLeaderTest.testDistribSearch

Error Message:


Stack Trace:
java.lang.NullPointerException
        at 
__randomizedtesting.SeedInfo.seed([9D91BDE760C23FDB:1C7733FF179D5FE7]:0)
        at 
org.apache.solr.client.solrj.impl.CloudSolrServer.requestWithRetryOnStaleState(CloudSolrServer.java:706)
        at 
org.apache.solr.client.solrj.impl.CloudSolrServer.request(CloudSolrServer.java:601)
        at 
org.apache.solr.client.solrj.request.AbstractUpdateRequest.process(AbstractUpdateRequest.java:124)
        at 
org.apache.solr.client.solrj.SolrServer.deleteByQuery(SolrServer.java:285)
        at 
org.apache.solr.client.solrj.SolrServer.deleteByQuery(SolrServer.java:271)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.del(AbstractFullDistribZkTestBase.java:728)
        at 
org.apache.solr.cloud.ChaosMonkeySafeLeaderTest.tryDelete(ChaosMonkeySafeLeaderTest.java:194)
        at 
org.apache.solr.cloud.ChaosMonkeySafeLeaderTest.doTest(ChaosMonkeySafeLeaderTest.java:112)
        at 
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
        at sun.reflect.GeneratedMethodAccessor39.invoke(Unknown Source)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:483)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 11288 lines...]
   [junit4] Suite: org.apache.solr.cloud.ChaosMonkeySafeLeaderTest
   [junit4]   2> Creating dataDir: 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/init-core-data-001
   [junit4]   2> 2658301 T7128 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl 
(true) and clientAuth (false)
   [junit4]   2> 2658302 T7128 
oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system 
property: /
   [junit4]   2> 2658309 T7128 oas.SolrTestCaseJ4.setUp ###Starting 
testDistribSearch
   [junit4]   2> 2658313 T7128 oasc.ZkTestServer.run STARTING ZK TEST SERVER
   [junit4]   1> client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2658315 T7129 oasc.ZkTestServer$ZKServerMain.runFromConfig 
Starting server
   [junit4]   2> 2658415 T7128 oasc.ZkTestServer.run start zk server on 
port:51023
   [junit4]   2> 2658416 T7128 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 2658422 T7128 oascc.ConnectionManager.waitForConnected Waiting 
for client to connect to ZooKeeper
   [junit4]   2> 2658430 T7135 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@405ed72e 
name:ZooKeeperConnection Watcher:127.0.0.1:51023 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2658431 T7128 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 2658431 T7128 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 2658433 T7128 oascc.SolrZkClient.makePath makePath: /solr
   [junit4]   2> 2658444 T7128 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 2658448 T7128 oascc.ConnectionManager.waitForConnected Waiting 
for client to connect to ZooKeeper
   [junit4]   2> 2658451 T7137 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@6d90284e 
name:ZooKeeperConnection Watcher:127.0.0.1:51023/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2658451 T7128 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 2658452 T7128 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 2658452 T7128 oascc.SolrZkClient.makePath makePath: 
/collections/collection1
   [junit4]   2> 2658457 T7128 oascc.SolrZkClient.makePath makePath: 
/collections/collection1/shards
   [junit4]   2> 2658464 T7128 oascc.SolrZkClient.makePath makePath: 
/collections/control_collection
   [junit4]   2> 2658467 T7128 oascc.SolrZkClient.makePath makePath: 
/collections/control_collection/shards
   [junit4]   2> 2658473 T7128 oasc.AbstractZkTestCase.putConfig put 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 2658473 T7128 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/solrconfig.xml
   [junit4]   2> 2658481 T7128 oasc.AbstractZkTestCase.putConfig put 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema15.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 2658482 T7128 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/schema.xml
   [junit4]   2> 2658489 T7128 oasc.AbstractZkTestCase.putConfig put 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 2658489 T7128 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 2658497 T7128 oasc.AbstractZkTestCase.putConfig put 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 2658498 T7128 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/stopwords.txt
   [junit4]   2> 2658506 T7128 oasc.AbstractZkTestCase.putConfig put 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 2658507 T7128 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/protwords.txt
   [junit4]   2> 2658512 T7128 oasc.AbstractZkTestCase.putConfig put 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 2658512 T7128 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/currency.xml
   [junit4]   2> 2658520 T7128 oasc.AbstractZkTestCase.putConfig put 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 2658520 T7128 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/enumsConfig.xml
   [junit4]   2> 2658528 T7128 oasc.AbstractZkTestCase.putConfig put 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 2658529 T7128 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/open-exchange-rates.json
   [junit4]   2> 2658536 T7128 oasc.AbstractZkTestCase.putConfig put 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 2658536 T7128 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 2658558 T7128 oasc.AbstractZkTestCase.putConfig put 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 2658559 T7128 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/old_synonyms.txt
   [junit4]   2> 2658564 T7128 oasc.AbstractZkTestCase.putConfig put 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 2658568 T7128 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/synonyms.txt
   [junit4]   2> 2658576 T7128 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 2658579 T7128 oascc.ConnectionManager.waitForConnected Waiting 
for client to connect to ZooKeeper
   [junit4]   2> 2658580 T7139 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@21519232 
name:ZooKeeperConnection Watcher:127.0.0.1:51023/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2658580 T7128 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 2658580 T7128 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 2660459 T7128 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 2660471 T7128 oejus.SslContextFactory.doStart Enabled 
Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, 
TLSv1, TLSv1.1, TLSv1.2]
   [junit4]   2> 2660473 T7128 oejs.AbstractConnector.doStart Started 
[email protected]:51027
   [junit4]   2> 2660476 T7128 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()
   [junit4]   2> 2660478 T7128 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 2660479 T7128 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-002
   [junit4]   2> 2660479 T7128 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-002/'
   [junit4]   2> 2660519 T7128 oasc.ConfigSolr.fromFile Loading container 
configuration from 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-002/solr.xml
   [junit4]   2> 2660537 T7128 oasc.CoreContainer.<init> New CoreContainer 
668295376
   [junit4]   2> 2660538 T7128 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-002/]
   [junit4]   2> 2660539 T7128 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 90000
   [junit4]   2> 2660539 T7128 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: 
   [junit4]   2> 2660539 T7128 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 15000
   [junit4]   2> 2660540 T7128 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 2660540 T7128 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 2660540 T7128 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 2660540 T7128 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 2660541 T7128 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 2660541 T7128 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 2660543 T7128 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 2660545 T7128 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 2660546 T7128 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 2660546 T7128 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 2660546 T7128 oasc.ZkContainer.initZooKeeper Zookeeper 
client=127.0.0.1:51023/solr
   [junit4]   2> 2660547 T7128 oasc.ZkController.checkChrootPath zkHost 
includes chroot
   [junit4]   2> 2660548 T7128 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 2660550 T7128 oascc.ConnectionManager.waitForConnected Waiting 
for client to connect to ZooKeeper
   [junit4]   2> 2660552 T7150 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@7abb9609 
name:ZooKeeperConnection Watcher:127.0.0.1:51023 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2660554 T7128 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 2660555 T7128 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 2660559 T7128 oascc.ConnectionManager.waitForConnected Waiting 
for client to connect to ZooKeeper
   [junit4]   2> 2660560 T7152 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@5d2e38f7 
name:ZooKeeperConnection Watcher:127.0.0.1:51023/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2660560 T7128 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 2660563 T7128 oascc.SolrZkClient.makePath makePath: 
/overseer/queue
   [junit4]   2> 2660568 T7128 oascc.SolrZkClient.makePath makePath: 
/overseer/collection-queue-work
   [junit4]   2> 2660573 T7128 oascc.SolrZkClient.makePath makePath: 
/overseer/collection-map-running
   [junit4]   2> 2660578 T7128 oascc.SolrZkClient.makePath makePath: 
/overseer/collection-map-completed
   [junit4]   2> 2660583 T7128 oascc.SolrZkClient.makePath makePath: 
/overseer/collection-map-failure
   [junit4]   2> 2660590 T7128 oascc.SolrZkClient.makePath makePath: /live_nodes
   [junit4]   2> 2660595 T7128 oasc.ZkController.createEphemeralLiveNode 
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:51027_
   [junit4]   2> 2660597 T7128 oascc.SolrZkClient.makePath makePath: 
/live_nodes/127.0.0.1:51027_
   [junit4]   2> 2660606 T7128 oascc.SolrZkClient.makePath makePath: 
/overseer_elect
   [junit4]   2> 2660610 T7128 oascc.SolrZkClient.makePath makePath: 
/overseer_elect/election
   [junit4]   2> 2660615 T7128 oasc.Overseer.close Overseer (id=null) closing
   [junit4]   2> 2660620 T7128 oasc.OverseerElectionContext.runLeaderProcess I 
am going to be the leader 127.0.0.1:51027_
   [junit4]   2> 2660620 T7128 oascc.SolrZkClient.makePath makePath: 
/overseer_elect/leader
   [junit4]   2> 2660627 T7128 oasc.Overseer.start Overseer 
(id=92458663216218116-127.0.0.1:51027_-n_0000000000) starting
   [junit4]   2> 2660635 T7128 oascc.SolrZkClient.makePath makePath: 
/overseer/queue-work
   [junit4]   2> 2660665 T7128 oasc.OverseerAutoReplicaFailoverThread.<init> 
Starting OverseerAutoReplicaFailoverThread 
autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 2660666 T7154 oasc.OverseerCollectionProcessor.run Process 
current queue of collection creations
   [junit4]   2> 2660669 T7128 oascc.SolrZkClient.makePath makePath: 
/clusterstate.json
   [junit4]   2> 2660675 T7128 oascc.SolrZkClient.makePath makePath: 
/aliases.json
   [junit4]   2> 2660679 T7128 
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 2660693 T7153 oasc.Overseer$ClusterStateUpdater.run Starting 
to work on the main queue
   [junit4]   2> 2660700 T7156 oasc.ZkController.publish publishing 
core=collection1 state=down collection=control_collection
   [junit4]   2> 2660701 T7156 oasc.ZkController.publish numShards not found on 
descriptor - reading it from system property
   [junit4]   2> 2660703 T7157 oasc.DistributedQueue$LatchChildWatcher.process 
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type 
NodeChildrenChanged
   [junit4]   2> 2660707 T7156 oasc.ZkController.waitForCoreNodeName look for 
our core node name
   [junit4]   2> 2660711 T7153 oasc.Overseer$ClusterStateUpdater.updateState 
Update state numShards=1 message={
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "base_url":"https://127.0.0.1:51027";,
   [junit4]   2>          "node_name":"127.0.0.1:51027_",
   [junit4]   2>          "numShards":"1",
   [junit4]   2>          "state":"down",
   [junit4]   2>          "shard":null,
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "operation":"state"}
   [junit4]   2> 2660711 T7153 
oasc.Overseer$ClusterStateUpdater.createCollection Create collection 
control_collection with shards [shard1]
   [junit4]   2> 2660711 T7153 
oasc.Overseer$ClusterStateUpdater.createCollection state version 
control_collection 1
   [junit4]   2> 2660711 T7153 oasc.Overseer$ClusterStateUpdater.updateState 
Assigning new node to shard shard=shard1
   [junit4]   2> 2660715 T7157 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> 2661708 T7156 oasc.ZkController.waitForShardId waiting to find 
shard id in clusterstate for collection1
   [junit4]   2> 2661709 T7156 oasc.ZkController.createCollectionZkNode Check 
for collection zkNode:control_collection
   [junit4]   2> 2661712 T7156 oasc.ZkController.createCollectionZkNode 
Collection zkNode exists
   [junit4]   2> 2661712 T7156 oascc.ZkStateReader.readConfigName Load 
collection config from:/collections/control_collection
   [junit4]   2> 2661718 T7156 oascc.ZkStateReader.readConfigName 
path=/collections/control_collection configName=conf1 specified config exists 
in ZooKeeper
   [junit4]   2> 2661718 T7156 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-002/collection1/'
   [junit4]   2> 2661720 T7156 oasc.SolrResourceLoader.replaceClassLoader 
Adding 
'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-002/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 2661722 T7156 oasc.SolrResourceLoader.replaceClassLoader 
Adding 
'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-002/collection1/lib/classes/'
 to classloader
   [junit4]   2> 2661723 T7156 oasc.SolrResourceLoader.replaceClassLoader 
Adding 
'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-002/collection1/lib/README'
 to classloader
   [junit4]   2> 2661770 T7156 oasc.SolrConfig.<init> Using Lucene 
MatchVersion: 5.0.0
   [junit4]   2> 2661794 T7156 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 2661796 T7156 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 2661804 T7156 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 2661915 T7156 oass.IndexSchema.readSchema default search field 
in schema is text
   [junit4]   2> 2661916 T7156 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 2661917 T7156 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 2661926 T7156 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 2661990 T7156 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from collection control_collection
   [junit4]   2> 2661991 T7156 oasc.SolrCore.initDirectoryFactory 
solr.StandardDirectoryFactory
   [junit4]   2> 2661991 T7156 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-002/collection1/,
 
dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/control/data/
   [junit4]   2> 2661991 T7156 oasc.JmxMonitoredMap.<init> JMX monitoring is 
enabled. Adding Solr mbeans to JMX Server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@65527925
   [junit4]   2> 2661994 T7156 oasc.CachingDirectoryFactory.get return new 
directory for 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/control/data
   [junit4]   2> 2661994 T7156 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/control/data/index/
   [junit4]   2> 2661995 T7156 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/control/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 2661996 T7156 oasc.CachingDirectoryFactory.get return new 
directory for 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/control/data/index
   [junit4]   2> 2661997 T7156 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=26, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=87.1201171875, 
floorSegmentMB=1.4130859375, forceMergeDeletesPctAllowed=11.502438378813286, 
segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.13592693577772286
   [junit4]   2> 2662001 T7156 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/control/data/index,segFN=segments_1,generation=1}
   [junit4]   2> 2662002 T7156 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 2662006 T7156 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "nodistrib"
   [junit4]   2> 2662006 T7156 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 2662006 T7156 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 2662007 T7156 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 2662007 T7156 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 2662008 T7156 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 2662008 T7156 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 2662009 T7156 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 2662009 T7156 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 2662009 T7156 oasc.RequestHandlers.initHandlersFromConfig 
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 2662010 T7156 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 2662011 T7156 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 2662012 T7156 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 2662012 T7156 oasc.RequestHandlers.initHandlersFromConfig 
created /get: solr.RealTimeGetHandler
   [junit4]   2> 2662013 T7156 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 2662013 T7156 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: solr.ReplicationHandler
   [junit4]   2> 2662014 T7156 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 2662014 T7156 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 2662015 T7156 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 2662015 T7156 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/fileedit: solr.admin.EditFileRequestHandler
   [junit4]   2> 2662023 T7156 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2662025 T7156 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2662027 T7156 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2662029 T7156 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2662042 T7156 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 2662042 T7156 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 2662043 T7156 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: 
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=22, 
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, 
calibrateSizeByDeletes=false, maxMergeDocs=2147483647, 
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 2662045 T7156 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/control/data/index,segFN=segments_1,generation=1}
   [junit4]   2> 2662045 T7156 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 2662045 T7156 oass.SolrIndexSearcher.<init> Opening 
Searcher@200b6d83[collection1] main
   [junit4]   2> 2662046 T7156 oascc.ZkStateReader.readConfigName Load 
collection config from:/collections/control_collection
   [junit4]   2> 2662050 T7156 oascc.ZkStateReader.readConfigName 
path=/collections/control_collection configName=conf1 specified config exists 
in ZooKeeper
   [junit4]   2> 2662050 T7156 oasr.ManagedResourceStorage.newStorageIO Setting 
up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
   [junit4]   2> 2662051 T7156 
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured 
ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 2662052 T7156 oasr.RestManager.init Initializing RestManager 
with initArgs: {}
   [junit4]   2> 2662052 T7156 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2662053 T7156 
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found 
for znode /configs/conf1/_rest_managed.json
   [junit4]   2> 2662054 T7156 oasr.ManagedResourceStorage.load Loaded null at 
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2662055 T7156 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/_rest_managed.json
   [junit4]   2> 2662060 T7156 
oasr.ManagedResourceStorage$ZooKeeperStorageIO$1.close Wrote 38 bytes to new 
znode /configs/conf1/_rest_managed.json
   [junit4]   2> 2662061 T7156 oasr.ManagedResourceStorage$JsonStorage.store 
Saved JSON object to path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2662061 T7156 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 2662064 T7158 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@200b6d83[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 2662066 T7156 oasc.CoreContainer.registerCore registering 
core: collection1
   [junit4]   2> 2662069 T7161 oasc.ZkController.register Register replica - 
core:collection1 address:https://127.0.0.1:51027 collection:control_collection 
shard:shard1
   [junit4]   2> 2662070 T7128 oass.SolrDispatchFilter.init 
user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
   [junit4]   2> 2662070 T7128 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init() done
   [junit4]   2> 2662071 T7161 oascc.SolrZkClient.makePath makePath: 
/collections/control_collection/leader_elect/shard1/election
   [junit4]   2> 2662074 T7128 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 2662075 T7128 oascc.ConnectionManager.waitForConnected Waiting 
for client to connect to ZooKeeper
   [junit4]   2> 2662080 T7163 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@3f5f991c 
name:ZooKeeperConnection Watcher:127.0.0.1:51023/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2662080 T7128 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 2662081 T7128 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 2662084 T7128 
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 2662088 T7161 oasc.ShardLeaderElectionContext.runLeaderProcess 
Running the leader process for shard shard1
   [junit4]   2> 2662094 T7128 oasc.ChaosMonkey.monkeyLog monkey: init - expire 
sessions:false cause connection loss:false
   [junit4]   2> 2662101 T7157 oasc.DistributedQueue$LatchChildWatcher.process 
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type 
NodeChildrenChanged
   [junit4]   2> 2662105 T7161 
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found 
to continue.
   [junit4]   2> 2662106 T7161 oasc.ShardLeaderElectionContext.runLeaderProcess 
I may be the new leader - try and sync
   [junit4]   2> ASYNC  NEW_CORE C4938 name=collection1 
org.apache.solr.core.SolrCore@166ee827 url=https://127.0.0.1:51027/collection1 
node=127.0.0.1:51027_ C4938_STATE=coll:control_collection core:collection1 
props:{core=collection1, base_url=https://127.0.0.1:51027, 
node_name=127.0.0.1:51027_, state=down}
   [junit4]   2> 2662106 T7161 C4938 P51027 oasc.SyncStrategy.sync Sync 
replicas to https://127.0.0.1:51027/collection1/
   [junit4]   2> 2662107 T7161 C4938 P51027 oasc.SyncStrategy.syncReplicas Sync 
Success - now sync replicas to me
   [junit4]   2> 2662107 T7161 C4938 P51027 oasc.SyncStrategy.syncToMe 
https://127.0.0.1:51027/collection1/ has no replicas
   [junit4]   2> 2662107 T7161 oasc.ShardLeaderElectionContext.runLeaderProcess 
I am the new leader: https://127.0.0.1:51027/collection1/ shard1
   [junit4]   2> 2662107 T7161 oascc.SolrZkClient.makePath makePath: 
/collections/control_collection/leaders/shard1
   [junit4]   2> 2662161 T7157 oasc.DistributedQueue$LatchChildWatcher.process 
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type 
NodeChildrenChanged
   [junit4]   2> 2662266 T7157 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> 2662267 T7164 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> 2662303 T7161 oasc.ZkController.register We are 
https://127.0.0.1:51027/collection1/ and leader is 
https://127.0.0.1:51027/collection1/
   [junit4]   2> 2662303 T7161 oasc.ZkController.register No LogReplay needed 
for core=collection1 baseURL=https://127.0.0.1:51027
   [junit4]   2> 2662303 T7161 oasc.ZkController.checkRecovery I am the leader, 
no recovery necessary
   [junit4]   2> 2662304 T7161 oasc.ZkController.publish publishing 
core=collection1 state=active collection=control_collection
   [junit4]   2> 2662304 T7161 oasc.ZkController.publish numShards not found on 
descriptor - reading it from system property
   [junit4]   2> 2662311 T7157 oasc.DistributedQueue$LatchChildWatcher.process 
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type 
NodeChildrenChanged
   [junit4]   2> 2662326 T7153 oasc.Overseer$ClusterStateUpdater.updateState 
Update state numShards=1 message={
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "base_url":"https://127.0.0.1:51027";,
   [junit4]   2>          "node_name":"127.0.0.1:51027_",
   [junit4]   2>          "numShards":"1",
   [junit4]   2>          "state":"active",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "operation":"state"}
   [junit4]   2> 2662434 T7164 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> 2662434 T7157 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> 2663891 T7128 oasc.AbstractFullDistribZkTestBase.createJettys 
create jetty 1
   [junit4]   2> 2663892 T7128 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 2663901 T7128 oejus.SslContextFactory.doStart Enabled 
Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, 
TLSv1, TLSv1.1, TLSv1.2]
   [junit4]   2> 2663903 T7128 oejs.AbstractConnector.doStart Started 
[email protected]:51031
   [junit4]   2> 2663909 T7128 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()
   [junit4]   2> 2663909 T7128 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 2663910 T7128 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-003
   [junit4]   2> 2663910 T7128 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-003/'
   [junit4]   2> 2663946 T7128 oasc.ConfigSolr.fromFile Loading container 
configuration from 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-003/solr.xml
   [junit4]   2> 2663963 T7128 oasc.CoreContainer.<init> New CoreContainer 
1316883938
   [junit4]   2> 2663964 T7128 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-003/]
   [junit4]   2> 2663965 T7128 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 90000
   [junit4]   2> 2663965 T7128 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: 
   [junit4]   2> 2663966 T7128 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 15000
   [junit4]   2> 2663966 T7128 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 2663967 T7128 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 2663967 T7128 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 2663967 T7128 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 2663968 T7128 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 2663968 T7128 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 2663970 T7128 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 2663972 T7128 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 2663972 T7128 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 2663974 T7128 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 2663974 T7128 oasc.ZkContainer.initZooKeeper Zookeeper 
client=127.0.0.1:51023/solr
   [junit4]   2> 2663974 T7128 oasc.ZkController.checkChrootPath zkHost 
includes chroot
   [junit4]   2> 2663974 T7128 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 2663976 T7128 oascc.ConnectionManager.waitForConnected Waiting 
for client to connect to ZooKeeper
   [junit4]   2> 2663981 T7175 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@32445441 
name:ZooKeeperConnection Watcher:127.0.0.1:51023 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2663982 T7128 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 2663983 T7128 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 2663985 T7128 oascc.ConnectionManager.waitForConnected Waiting 
for client to connect to ZooKeeper
   [junit4]   2> 2663988 T7177 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@7de157ab 
name:ZooKeeperConnection Watcher:127.0.0.1:51023/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2663989 T7128 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 2664008 T7128 
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 2665025 T7128 oasc.ZkController.createEphemeralLiveNode 
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:51031_
   [junit4]   2> 2665033 T7128 oascc.SolrZkClient.makePath makePath: 
/live_nodes/127.0.0.1:51031_
   [junit4]   2> 2665049 T7128 oasc.Overseer.close Overseer (id=null) closing
   [junit4]   2> 2665061 T7179 oasc.ZkController.publish publishing 
core=collection1 state=down collection=collection1
   [junit4]   2> 2665062 T7179 oasc.ZkController.publish numShards not found on 
descriptor - reading it from system property
   [junit4]   2> 2665064 T7157 oasc.DistributedQueue$LatchChildWatcher.process 
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type 
NodeChildrenChanged
   [junit4]   2> 2665064 T7179 oasc.ZkController.waitForCoreNodeName look for 
our core node name
   [junit4]   2> 2665076 T7153 oasc.Overseer$ClusterStateUpdater.updateState 
Update state numShards=1 message={
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "base_url":"https://127.0.0.1:51031";,
   [junit4]   2>          "node_name":"127.0.0.1:51031_",
   [junit4]   2>          "numShards":"1",
   [junit4]   2>          "state":"down",
   [junit4]   2>          "shard":null,
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "operation":"state"}
   [junit4]   2> 2665077 T7153 
oasc.Overseer$ClusterStateUpdater.createCollection Create collection 
collection1 with shards [shard1]
   [junit4]   2> 2665077 T7153 
oasc.Overseer$ClusterStateUpdater.createCollection state version collection1 1
   [junit4]   2> 2665077 T7153 oasc.Overseer$ClusterStateUpdater.updateState 
Assigning new node to shard shard=shard1
   [junit4]   2> 2665085 T7164 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
   [junit4]   2> 2665086 T7178 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
   [junit4]   2> 2665086 T7157 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
   [junit4]   2> 2666066 T7179 oasc.ZkController.waitForShardId waiting to find 
shard id in clusterstate for collection1
   [junit4]   2> 2666067 T7179 oasc.ZkController.createCollectionZkNode Check 
for collection zkNode:collection1
   [junit4]   2> 2666071 T7179 oasc.ZkController.createCollectionZkNode 
Collection zkNode exists
   [junit4]   2> 2666072 T7179 oascc.ZkStateReader.readConfigName Load 
collection config from:/collections/collection1
   [junit4]   2> 2666075 T7179 oascc.ZkStateReader.readConfigName 
path=/collections/collection1 configName=conf1 specified config exists in 
ZooKeeper
   [junit4]   2> 2666076 T7179 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-003/collection1/'
   [junit4]   2> 2666078 T7179 oasc.SolrResourceLoader.replaceClassLoader 
Adding 
'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-003/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 2666079 T7179 oasc.SolrResourceLoader.replaceClassLoader 
Adding 
'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-003/collection1/lib/classes/'
 to classloader
   [junit4]   2> 2666080 T7179 oasc.SolrResourceLoader.replaceClassLoader 
Adding 
'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-003/collection1/lib/README'
 to classloader
   [junit4]   2> 2666138 T7179 oasc.SolrConfig.<init> Using Lucene 
MatchVersion: 5.0.0
   [junit4]   2> 2666163 T7179 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 2666166 T7179 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 2666170 T7179 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 2666296 T7179 oass.IndexSchema.readSchema default search field 
in schema is text
   [junit4]   2> 2666297 T7179 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 2666298 T7179 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 2666304 T7179 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 2666381 T7179 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from collection collection1
   [junit4]   2> 2666382 T7179 oasc.SolrCore.initDirectoryFactory 
solr.StandardDirectoryFactory
   [junit4]   2> 2666383 T7179 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-003/collection1/,
 
dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/jetty1/
   [junit4]   2> 2666383 T7179 oasc.JmxMonitoredMap.<init> JMX monitoring is 
enabled. Adding Solr mbeans to JMX Server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@65527925
   [junit4]   2> 2666384 T7179 oasc.CachingDirectoryFactory.get return new 
directory for 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/jetty1
   [junit4]   2> 2666386 T7179 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/jetty1/index/
   [junit4]   2> 2666386 T7179 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/jetty1/index'
 doesn't exist. Creating new index...
   [junit4]   2> 2666388 T7179 oasc.CachingDirectoryFactory.get return new 
directory for 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/jetty1/index
   [junit4]   2> 2666389 T7179 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=26, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=87.1201171875, 
floorSegmentMB=1.4130859375, forceMergeDeletesPctAllowed=11.502438378813286, 
segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.13592693577772286
   [junit4]   2> 2666393 T7179 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/jetty1/index,segFN=segments_1,generation=1}
   [junit4]   2> 2666393 T7179 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 2666399 T7179 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "nodistrib"
   [junit4]   2> 2666400 T7179 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 2666400 T7179 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 2666400 T7179 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 2666403 T7179 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 2666403 T7179 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 2666404 T7179 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 2666404 T7179 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 2666404 T7179 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 2666405 T7179 oasc.RequestHandlers.initHandlersFromConfig 
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 2666406 T7179 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 2666406 T7179 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 2666407 T7179 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 2666408 T7179 oasc.RequestHandlers.initHandlersFromConfig 
created /get: solr.RealTimeGetHandler
   [junit4]   2> 2666408 T7179 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 2666409 T7179 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: solr.ReplicationHandler
   [junit4]   2> 2666409 T7179 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 2666410 T7179 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 2666410 T7179 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 2666411 T7179 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/fileedit: solr.admin.EditFileRequestHandler
   [junit4]   2> 2666417 T7179 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2666418 T7179 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2666419 T7179 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2666421 T7179 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 2666424 T7179 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 2666424 T7179 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 2666425 T7179 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: 
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=22, 
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, 
calibrateSizeByDeletes=false, maxMergeDocs=2147483647, 
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 2666426 T7179 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/jetty1/index,segFN=segments_1,generation=1}
   [junit4]   2> 2666426 T7179 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 2666427 T7179 oass.SolrIndexSearcher.<init> Opening 
Searcher@570a0ed1[collection1] main
   [junit4]   2> 2666427 T7179 oascc.ZkStateReader.readConfigName Load 
collection config from:/collections/collection1
   [junit4]   2> 2666431 T7179 oascc.ZkStateReader.readConfigName 
path=/collections/collection1 configName=conf1 specified config exists in 
ZooKeeper
   [junit4]   2> 2666431 T7179 oasr.ManagedResourceStorage.newStorageIO Setting 
up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
   [junit4]   2> 2666433 T7179 
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured 
ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 2666434 T7179 oasr.RestManager.init Initializing RestManager 
with initArgs: {}
   [junit4]   2> 2666434 T7179 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2666438 T7179 
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream Read 38 bytes 
from znode /configs/conf1/_rest_managed.json
   [junit4]   2> 2666438 T7179 oasr.ManagedResourceStorage.load Loaded 
LinkedHashMap at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2666439 T7179 oasr.ManagedResource.reloadFromStorage Loaded 
initArgs {} for /rest/managed
   [junit4]   2> 2666439 T7179 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 2666446 T7180 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@570a0ed1[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 2666449 T7179 oasc.CoreContainer.registerCore registering 
core: collection1
   [junit4]   2> 2666453 T7183 oasc.ZkController.register Register replica - 
core:collection1 address:https://127.0.0.1:51031 collection:collection1 
shard:shard1
   [junit4]   2> 2666453 T7128 oass.SolrDispatchFilter.init 
user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
   [junit4]   2> 2666454 T7128 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init() done
   [junit4]   2> 2666456 T7183 oascc.SolrZkClient.makePath makePath: 
/collections/collection1/leader_elect/shard1/election
   [junit4]   2> 2666467 T7128 
oasc.AbstractFullDistribZkTestBase.randomlyEnableAutoSoftCommit Not turning on 
auto soft commit
   [junit4]   2> 2666476 T7183 oasc.ShardLeaderElectionContext.runLeaderProcess 
Running the leader process for shard shard1
   [junit4]   2> 2666480 T7183 
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found 
to continue.
   [junit4]   2> 2666480 T7183 oasc.ShardLeaderElectionContext.runLeaderProcess 
I may be the new leader - try and sync
   [junit4]   2> ASYNC  NEW_CORE C4939 name=collection1 
org.apache.solr.core.SolrCore@7bb875df url=https://127.0.0.1:51031/collection1 
node=127.0.0.1:51031_ C4939_STATE=coll:collection1 core:collection1 
props:{core=collection1, base_url=https://127.0.0.1:51031, 
node_name=127.0.0.1:51031_, state=down}
   [junit4]   2> 2666480 T7183 C4939 P51031 oasc.SyncStrategy.sync Sync 
replicas to https://127.0.0.1:51031/collection1/
   [junit4]   2> 2666480 T7183 C4939 P51031 oasc.SyncStrategy.syncReplicas Sync 
Success - now sync replicas to me
   [junit4]   2> 2666480 T7183 C4939 P51031 oasc.SyncStrategy.syncToMe 
https://127.0.0.1:51031/collection1/ has no replicas
   [junit4]   2> 2666481 T7183 oasc.ShardLeaderElectionContext.runLeaderProcess 
I am the new leader: https://127.0.0.1:51031/collection1/ shard1
   [junit4]   2> 2666481 T7183 oascc.SolrZkClient.makePath makePath: 
/collections/collection1/leaders/shard1
   [junit4]   2> 2666488 T7157 oasc.DistributedQueue$LatchChildWatcher.process 
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type 
NodeChildrenChanged
   [junit4]   2> 2666499 T7157 oasc.DistributedQueue$LatchChildWatcher.process 
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type 
NodeChildrenChanged
   [junit4]   2> ASYNC  NEW_CORE C4940 name=collection1 
org.apache.solr.core.SolrCore@166ee827 url=https://127.0.0.1:51027/collection1 
node=127.0.0.1:51027_ C4940_STATE=coll:control_collection core:collection1 
props:{core=collection1, base_url=https://127.0.0.1:51027, 
node_name=127.0.0.1:51027_, state=active, leader=true}
   [junit4]   2> 2666509 T7148 C4940 P51027 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={wt=javabin&version=2} 
{deleteByQuery=*:* (-1479338620036841472)} 0 7
   [junit4]   2> 2666511 T7128 
oascsi.CloudSolrServer.requestWithRetryOnStaleState ERROR Request to collection 
collection1 failed due to (510) org.apache.solr.common.SolrException: Not 
enough nodes to handle the request, retry? 0
   [junit4]   2> 2666518 T7128 oasc.ChaosMonkey.monkeyLog monkey: stop shard! 
51027
   [junit4]   2> 2666518 T7128 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=668295376
   [junit4]   2> 2666518 T7128 oasc.ZkController.publish publishing 
core=collection1 state=down collection=control_collection
   [junit4]   2> 2666519 T7128 oasc.ZkController.publish numShards not found on 
descriptor - reading it from system property
   [junit4]   2> 2666520 T7157 oasc.DistributedQueue$LatchChildWatcher.process 
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type 
NodeChildrenChanged
   [junit4]   2> 2666521 T7128 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@166ee827
   [junit4]   2> 2666522 T7153 oasc.Overseer$ClusterStateUpdater.updateState 
Update state numShards=null message={
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "base_url":"https://127.0.0.1:51027";,
   [junit4]   2>          "node_name":"127.0.0.1:51027_",
   [junit4]   2>          "state":"down",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "operation":"state"}
   [junit4]   2> 2666525 T7128 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=0,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=1,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
   [junit4]   2> 2666526 T7128 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 2666528 T7128 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 2666528 T7128 oasu.DefaultSolrCoreState.closeIndexWriter 
closing IndexWriter with IndexWriterCloser
   [junit4]   2> 2666529 T7128 C4940 P51027 
oasu.DirectUpdateHandler2.closeWriter Committing on IndexWriter close.
   [junit4]   2> 2666534 T7128 C4940 P51027 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/control/data/index,segFN=segments_1,generation=1}
   [junit4]   2>                
commit{dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/control/data/index,segFN=segments_2,generation=2}
   [junit4]   2> 2666535 T7128 C4940 P51027 
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 2666537 T7128 oasc.SolrCore.closeSearcher [collection1] 
Closing main searcher on request.
   [junit4]   2> 2666537 T7128 oasc.CachingDirectoryFactory.close Closing 
StandardDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 2666538 T7128 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/control/data/index
 
[CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/control/data/index;done=false>>]
   [junit4]   2> 2666538 T7128 oasc.CachingDirectoryFactory.close Closing 
directory: 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/control/data/index
   [junit4]   2> 2666539 T7128 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/control/data
 
[CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/control/data;done=false>>]
   [junit4]   2> 2666539 T7128 oasc.CachingDirectoryFactory.close Closing 
directory: 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/control/data
   [junit4]   2> 2666540 T7128 oasc.Overseer.close Overseer 
(id=92458663216218116-127.0.0.1:51027_-n_0000000000) closing
   [junit4]   2> 2666540 T7153 oasc.Overseer$ClusterStateUpdater.run Overseer 
Loop exiting : 127.0.0.1:51027_
   [junit4]   2> 2666546 T7157 oascc.ZkStateReader$3.process WARN ZooKeeper 
watch triggered, but Solr cannot talk to ZK
   [junit4]   2> 2666552 T7185 oasc.OverseerElectionContext.runLeaderProcess I 
am going to be the leader 127.0.0.1:51031_
   [junit4]   2> 2666552 T7185 oascc.SolrZkClient.makePath makePath: 
/overseer_elect/leader
   [junit4]   2> 2666559 T7185 oasc.Overseer.start Overseer 
(id=92458663216218119-127.0.0.1:51031_-n_0000000001) starting
   [junit4]   2> 2666562 T7128 oejsh.ContextHandler.doStop stopped 
o.e.j.s.ServletContextHandler{/,null}
   [junit4]   2> 2666602 T7185 oasc.OverseerAutoReplicaFailoverThread.<init> 
Starting OverseerAutoReplicaFailoverThread 
autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 2666605 T7187 oasc.OverseerCollectionProcessor.run Process 
current queue of collection creations
   [junit4]   2> 2666622 T7186 oasc.Overseer$ClusterStateUpdater.run Replaying 
operations from work queue.
   [junit4]   2> 2666626 T7185 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> 2666648 T7186 oasc.Overseer$ClusterStateUpdater.updateState 
Update state numShards=null message={
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "base_url":"https://127.0.0.1:51027";,
   [junit4]   2>          "node_name":"127.0.0.1:51027_",
   [junit4]   2>          "state":"down",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "operation":"state"}
   [junit4]   2> 2666660 T7186 oasc.Overseer$ClusterStateUpdater.run Starting 
to work on the main queue
   [junit4]   2> 2666703 T7183 oasc.ZkController.register We are 
https://127.0.0.1:51031/collection1/ and leader is 
https://127.0.0.1:51031/collection1/
   [junit4]   2> 2666703 T7183 oasc.ZkController.register No LogReplay needed 
for core=collection1 baseURL=https://127.0.0.1:51031
   [junit4]   2> 2666704 T7183 oasc.ZkController.checkRecovery I am the leader, 
no recovery necessary
   [junit4]   2> 2666705 T7183 oasc.ZkController.publish publishing 
core=collection1 state=active collection=collection1
   [junit4]   2> 2666705 T7183 oasc.ZkController.publish numShards not found on 
descriptor - reading it from system property
   [junit4]   2> 2666710 T7185 oasc.DistributedQueue$LatchChildWatcher.process 
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type 
NodeChildrenChanged
   [junit4]   2> 2666730 T7186 oasc.Overseer$ClusterStateUpdater.updateState 
Update state numShards=null message={
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "base_url":"https://127.0.0.1:51031";,
   [junit4]   2>          "node_name":"127.0.0.1:51031_",
   [junit4]   2>          "state":"active",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "operation":"state"}
   [junit4]   2> 2666843 T7185 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> 2668045 T7184 
oasc.Overseer$ClusterStateUpdater.checkIfIamStillLeader ERROR could not read 
the data org.apache.zookeeper.KeeperException$SessionExpiredException: 
KeeperErrorCode = Session expired for /overseer_elect/leader
   [junit4]   2>        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
   [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:347)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:344)
   [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:344)
   [junit4]   2>        at 
org.apache.solr.cloud.Overseer$ClusterStateUpdater.checkIfIamStillLeader(Overseer.java:346)
   [junit4]   2>        at 
org.apache.solr.cloud.Overseer$ClusterStateUpdater.access$300(Overseer.java:89)
   [junit4]   2>        at 
org.apache.solr.cloud.Overseer$ClusterStateUpdater$1.run(Overseer.java:296)
   [junit4]   2> 
   [junit4]   2> 2671552 T7128 oasc.ChaosMonkey.monkeyLog monkey: stop shard! 
51031
   [junit4]   2> 2671553 T7128 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=1316883938
   [junit4]   2> 2671554 T7128 oasc.ZkController.publish publishing 
core=collection1 state=down collection=collection1
   [junit4]   2> 2671556 T7128 oasc.ZkController.publish numShards not found on 
descriptor - reading it from system property
   [junit4]   2> 2671561 T7128 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@7bb875df
   [junit4]   2> 2671561 T7185 oasc.DistributedQueue$LatchChildWatcher.process 
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type 
NodeChildrenChanged
   [junit4]   2> 2671574 T7186 oasc.Overseer$ClusterStateUpdater.updateState 
Update state numShards=null message={
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "base_url":"https://127.0.0.1:51031";,
   [junit4]   2>          "node_name":"127.0.0.1:51031_",
   [junit4]   2>          "state":"down",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "operation":"state"}
   [junit4]   2> 2671578 T7128 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=0,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
   [junit4]   2> 2671578 T7128 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 2671578 T7128 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 2671579 T7128 oasu.DefaultSolrCoreState.closeIndexWriter 
closing IndexWriter with IndexWriterCloser
   [junit4]   2> 2671579 T7185 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> 2671583 T7128 oasc.SolrCore.closeSearcher [collection1] 
Closing main searcher on request.
   [junit4]   2> 2671583 T7128 oasc.CachingDirectoryFactory.close Closing 
StandardDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 2671584 T7128 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/jetty1/index
 
[CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/jetty1/index;done=false>>]
   [junit4]   2> 2671585 T7128 oasc.CachingDirectoryFactory.close Closing 
directory: 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/jetty1/index
   [junit4]   2> 2671585 T7128 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/jetty1
 
[CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/jetty1;done=false>>]
   [junit4]   2> 2671585 T7128 oasc.CachingDirectoryFactory.close Closing 
directory: 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001/tempDir-001/jetty1
   [junit4]   2> 2671587 T7128 oasc.Overseer.close Overseer 
(id=92458663216218119-127.0.0.1:51031_-n_0000000001) closing
   [junit4]   2> 2671587 T7186 oasc.Overseer$ClusterStateUpdater.run Overseer 
Loop exiting : 127.0.0.1:51031_
   [junit4]   2> 2671592 T7177 oaz.ClientCnxn$EventThread.processEvent ERROR 
Error while calling watcher  java.util.concurrent.RejectedExecutionException: 
Task java.util.concurrent.FutureTask@1a8b885f rejected from 
java.util.concurrent.ThreadPoolExecutor@5f89056a[Shutting down, pool size = 1, 
active threads = 1, queued tasks = 0, completed tasks = 8]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2047)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:823)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1369)
   [junit4]   2>        at 
java.util.concurrent.AbstractExecutorService.submit(AbstractExecutorService.java:112)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$3.process(SolrZkClient.java:263)
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522)
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498)
   [junit4]   2> 
   [junit4]   2> 2673090 T7185 oascc.ZkStateReader.getIndividualColls WARN 
Error reading collections nodes 
org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = 
Session expired for /collections/collection1/state.json
   [junit4]   2>        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
   [junit4]   2>        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
   [junit4]   2>        at 
org.apache.zookeeper.ZooKeeper.exists(ZooKeeper.java:1045)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$5.execute(SolrZkClient.java:313)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$5.execute(SolrZkClient.java:310)
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:61)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient.exists(SolrZkClient.java:310)
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkStateReader.getIndividualColls(ZkStateReader.java:483)
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkStateReader.constructState(ZkStateReader.java:448)
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkStateReader.access$200(ZkStateReader.java:55)
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkStateReader$2.process(ZkStateReader.java:315)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$3$1.run(SolrZkClient.java:266)
   [junit4]   2>        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 
   [junit4]   2> 2673091 T7185 oascc.ZkStateReader.getIndividualColls WARN 
Error reading collections nodes 
org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = 
Session expired for /collections/control_collection/state.json
   [junit4]   2>        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
   [junit4]   2>        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
   [junit4]   2>        at 
org.apache.zookeeper.ZooKeeper.exists(ZooKeeper.java:1045)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$5.execute(SolrZkClient.java:313)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$5.execute(SolrZkClient.java:310)
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:61)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient.exists(SolrZkClient.java:310)
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkStateReader.getIndividualColls(ZkStateReader.java:483)
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkStateReader.constructState(ZkStateReader.java:448)
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkStateReader.access$200(ZkStateReader.java:55)
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkStateReader$2.process(ZkStateReader.java:315)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$3$1.run(SolrZkClient.java:266)
   [junit4]   2>        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 
   [junit4]   2> 2673093 T7189 
oasc.Overseer$ClusterStateUpdater.checkIfIamStillLeader ERROR could not read 
the data org.apache.zookeeper.KeeperException$SessionExpiredException: 
KeeperErrorCode = Session expired for /overseer_elect/leader
   [junit4]   2>        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
   [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:347)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:344)
   [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:344)
   [junit4]   2>        at 
org.apache.solr.cloud.Overseer$ClusterStateUpdater.checkIfIamStillLeader(Overseer.java:346)
   [junit4]   2>        at 
org.apache.solr.cloud.Overseer$ClusterStateUpdater.access$300(Overseer.java:89)
   [junit4]   2>        at 
org.apache.solr.cloud.Overseer$ClusterStateUpdater$1.run(Overseer.java:296)
   [junit4]   2> 
   [junit4]   2> 2673115 T7128 oejsh.ContextHandler.doStop stopped 
o.e.j.s.ServletContextHandler{/,null}
   [junit4]   2> 2678101 T7128 oas.SolrTestCaseJ4.tearDown ###Ending 
testDistribSearch
   [junit4]   2> 2678107 T7128 oasc.ZkTestServer.send4LetterWord connecting to 
127.0.0.1:51023 51023
   [junit4]   2> 2678286 T7129 oasc.ZkTestServer.send4LetterWord connecting to 
127.0.0.1:51023 51023
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=ChaosMonkeySafeLeaderTest -Dtests.method=testDistribSearch 
-Dtests.seed=9D91BDE760C23FDB -Dtests.slow=true -Dtests.locale=vi 
-Dtests.timezone=Pacific/Palau -Dtests.file.encoding=UTF-8
   [junit4] ERROR   20.3s | ChaosMonkeySafeLeaderTest.testDistribSearch <<<
   [junit4]    > Throwable #1: java.lang.NullPointerException
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([9D91BDE760C23FDB:1C7733FF179D5FE7]:0)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrServer.requestWithRetryOnStaleState(CloudSolrServer.java:706)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrServer.request(CloudSolrServer.java:601)
   [junit4]    >        at 
org.apache.solr.client.solrj.request.AbstractUpdateRequest.process(AbstractUpdateRequest.java:124)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrServer.deleteByQuery(SolrServer.java:285)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrServer.deleteByQuery(SolrServer.java:271)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.del(AbstractFullDistribZkTestBase.java:728)
   [junit4]    >        at 
org.apache.solr.cloud.ChaosMonkeySafeLeaderTest.tryDelete(ChaosMonkeySafeLeaderTest.java:194)
   [junit4]    >        at 
org.apache.solr.cloud.ChaosMonkeySafeLeaderTest.doTest(ChaosMonkeySafeLeaderTest.java:112)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2678569 T7128 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-9D91BDE760C23FDB-001
   [junit4]   2> NOTE: test params are: codec=Lucene410: {}, docValues:{}, 
sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {}, locale=vi, 
timezone=Pacific/Palau
   [junit4]   2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.8.0_20 
(64-bit)/cpus=2,threads=1,free=319795856,total=461049856
   [junit4]   2> NOTE: All tests run in this JVM: [TestManagedSchema, 
DistributedQueryElevationComponentTest, MultiTermTest, 
SpellingQueryConverterTest, TestStandardQParsers, TestSimpleQParserPlugin, 
ReturnFieldsTest, PathHierarchyTokenizerFactoryTest, 
TestPostingsSolrHighlighter, TestRemoteStreaming, TestCodecSupport, 
BlockDirectoryTest, SolrPluginUtilsTest, TestDocSet, 
TestPartialUpdateDeduplication, UpdateParamsTest, MoreLikeThisHandlerTest, 
TimeZoneUtilsTest, TestValueSourceCache, MergeStrategyTest, 
ExternalCollectionsTest, TestReRankQParserPlugin, 
TestDefaultSearchFieldResource, SampleTest, RankQueryTest, 
TestQuerySenderListener, TestFieldResource, TestSolrCoreProperties, 
TestManagedSchemaDynamicFieldResource, NotRequiredUniqueKeyTest, 
TestIndexSearcher, BadComponentTest, PrimUtilsTest, 
FullSolrCloudDistribCmdsTest, TestManagedResource, TestShardHandlerFactory, 
TestClassNameShortening, FastVectorHighlighterTest, 
TestSolrQueryParserDefaultOperatorResource, TestMissingGroups, 
TestUniqueKeyFieldResource, OverriddenZkACLAndCredentialsProvidersTest, 
StressHdfsTest, HighlighterMaxOffsetTest, TestSortingResponseWriter, 
DirectUpdateHandlerOptimizeTest, TestCustomSort, HardAutoCommitTest, 
TestFieldTypeCollectionResource, SSLMigrationTest, TestRangeQuery, 
TestDistributedMissingSort, QueryParsingTest, ReplicationFactorTest, 
TestConfigSets, TestSolr4Spatial2, TestSolr4Spatial, TestDynamicFieldResource, 
RemoteQueryErrorTest, TestStressRecovery, TestManagedSchemaFieldTypeResource, 
TestJmxMonitoredMap, FieldAnalysisRequestHandlerTest, 
HdfsChaosMonkeySafeLeaderTest, CurrencyFieldXmlFileTest, TermsComponentTest, 
TestFaceting, InfoHandlerTest, TestBM25SimilarityFactory, HdfsSyncSliceTest, 
ScriptEngineTest, AddSchemaFieldsUpdateProcessorFactoryTest, 
DistributedQueryComponentOptimizationTest, QueryElevationComponentTest, 
CoreAdminRequestStatusTest, TestSolrIndexConfig, SolrRequestParserTest, 
TestCollationField, TestDefaultSimilarityFactory, 
DeleteLastCustomShardedReplicaTest, TestQueryTypes, TestBadConfig, TestReload, 
TestAddFieldRealTimeGet, OverseerTest, 
StatelessScriptUpdateProcessorFactoryTest, TestLeaderElectionZkExpiry, 
FieldFacetExtrasTest, TestCharFilters, DocValuesMissingTest, TestLFUCache, 
DeleteReplicaTest, CopyFieldTest, QueryResultKeyTest, TestComponentsName, 
SuggesterFSTTest, BasicZkTest, TestFieldCollectionResource, SuggesterTSTTest, 
TestNRTOpen, BasicFunctionalityTest, TestSolrQueryParserResource, 
HdfsUnloadDistributedZkTest, TestStressUserVersions, QueryEqualityTest, 
DocValuesTest, TestReloadAndDeleteDocs, HdfsWriteToMultipleCollectionsTest, 
SolrTestCaseJ4Test, CircularListTest, CoreAdminCreateDiscoverTest, 
PingRequestHandlerTest, BlockCacheTest, AnalysisErrorHandlingTest, 
LeaderElectionIntegrationTest, TestSurroundQueryParser, NumericFieldsTest, 
ExternalFileFieldSortTest, HighlighterTest, 
DistribDocExpirationUpdateProcessorTest, LegacyHTMLStripCharFilterTest, 
TestTolerantSearch, SoftAutoCommitTest, TestCloudPivotFacet, CursorPagingTest, 
TestSearcherReuse, TestGroupingSearch, TestHighFrequencyDictionaryFactory, 
PluginInfoTest, EnumFieldTest, RollingRestartTest, TestImplicitCoreProperties, 
TestShortCircuitedRequests, OverseerCollectionProcessorTest, 
AlternateDirectoryTest, PreAnalyzedFieldTest, TestCollapseQParserPlugin, 
LeaderElectionTest, SignatureUpdateProcessorFactoryTest, TestLRUCache, 
SolrCoreCheckLockOnStartupTest, RAMDirectoryFactoryTest, TestXIncludeConfig, 
TestHighlightDedupGrouping, SliceStateTest, SyncSliceTest, TestRealTimeGet, 
TestSort, TestFunctionQuery, TestMaxScoreQueryParser, TestStressVersions, 
DocExpirationUpdateProcessorFactoryTest, TestPerFieldSimilarity, 
CustomCollectionTest, TestFileDictionaryLookup, ShowFileRequestHandlerTest, 
TestAtomicUpdateErrorCases, IndexSchemaRuntimeFieldTest, 
BasicDistributedZk2Test, TestParamSet, TestDistributedGrouping, 
TestSolrDeletionPolicy1, TestManagedSynonymFilterFactory, 
CurrencyFieldOpenExchangeTest, RecoveryZkTest, TestMultiCoreConfBootstrap, 
SharedFSAutoReplicaFailoverTest, RequiredFieldsTest, TestExtendedDismaxParser, 
DistributedSuggestComponentTest, TestPhraseSuggestions, PolyFieldTest, 
TestCloudManagedSchema, DateMathParserTest, TestNonDefinedSimilarityFactory, 
HdfsCollectionsAPIDistributedZkTest, WordBreakSolrSpellCheckerTest, 
DistributedFacetPivotSmallTest, DocumentAnalysisRequestHandlerTest, 
TestHashPartitioner, TestLazyCores, SOLR749Test, HdfsLockFactoryTest, 
OverseerRolesTest, TestSchemaSimilarityResource, BasicDistributedZkTest, 
DOMUtilTest, SystemInfoHandlerTest, SpellPossibilityIteratorTest, 
EchoParamsTest, TestOrdValues, AbstractAnalyticsFacetTest, 
TermVectorComponentTest, TestRestManager, TestDynamicFieldCollectionResource, 
MBeansHandlerTest, TestRandomMergePolicy, BJQParserTest, TestNonNRTOpen, 
DistributedExpandComponentTest, HdfsBasicDistributedZkTest, TestSolrJ, 
TestNoOpRegenerator, TestPivotHelperCode, ShardRoutingCustomTest, 
DebugComponentTest, DistanceFunctionTest, TestUtils, HttpPartitionTest, 
OverseerStatusTest, TestCloudSchemaless, TestSolrDeletionPolicy2, 
BadCopyFieldTest, SolrCmdDistributorTest, ChaosMonkeySafeLeaderTest]
   [junit4] Completed in 20.31s, 1 test, 1 error <<< FAILURES!

[...truncated 686 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:491: The following 
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:471: The following 
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:60: The following 
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/extra-targets.xml:39: The 
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build.xml:189: The 
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/common-build.xml:496: 
The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:1358: 
The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:961: 
There were test failures: 438 suites, 1830 tests, 1 error, 50 ignored (22 
assumptions)

Total time: 147 minutes 15 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.8.0 
-XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any


---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to