You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2014/11/23 12:00:13 UTC

[JENKINS] Lucene-Solr-5.x-MacOSX (64bit/jdk1.7.0) - Build # 1910 - Failure!

Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-MacOSX/1910/
Java: 64bit/jdk1.7.0 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC (asserts: false)

1 tests failed.
FAILED:  org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testDistribSearch

Error Message:
some core start times did not change on reload

Stack Trace:
java.lang.AssertionError: some core start times did not change on reload
	at __randomizedtesting.SeedInfo.seed([B2E40A0D454A5104:3302841532153138]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testCollectionsAPI(CollectionsAPIDistributedZkTest.java:884)
	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.doTest(CollectionsAPIDistributedZkTest.java:203)
	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
	at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 11606 lines...]
   [junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
   [junit4]   2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/init-core-data-001
   [junit4]   2> 5128942 T11771 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 5128943 T11771 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /
   [junit4]   2> 5128952 T11771 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
   [junit4]   2> 5128953 T11771 oasc.ZkTestServer.run STARTING ZK TEST SERVER
   [junit4]   1> client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 5128955 T11772 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server
   [junit4]   2> 5129054 T11771 oasc.ZkTestServer.run start zk server on port:59999
   [junit4]   2> 5129055 T11771 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
   [junit4]   2> 5129057 T11771 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 5129068 T11779 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@4acc5621 name:ZooKeeperConnection Watcher:127.0.0.1:59999 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 5129069 T11771 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 5129070 T11771 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
   [junit4]   2> 5129070 T11771 oascc.SolrZkClient.makePath makePath: /solr
   [junit4]   2> 5129082 T11771 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
   [junit4]   2> 5129086 T11771 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 5129090 T11782 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6838dacb name:ZooKeeperConnection Watcher:127.0.0.1:59999/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 5129091 T11771 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 5129091 T11771 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
   [junit4]   2> 5129092 T11771 oascc.SolrZkClient.makePath makePath: /collections/collection1
   [junit4]   2> 5129101 T11771 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
   [junit4]   2> 5129110 T11771 oascc.SolrZkClient.makePath makePath: /collections/control_collection
   [junit4]   2> 5129116 T11771 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
   [junit4]   2> 5129125 T11771 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml
   [junit4]   2> 5129126 T11771 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 5129137 T11771 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
   [junit4]   2> 5129138 T11771 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
   [junit4]   2> 5129144 T11771 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 5129145 T11771 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 5129155 T11771 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
   [junit4]   2> 5129156 T11771 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
   [junit4]   2> 5129164 T11771 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
   [junit4]   2> 5129164 T11771 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
   [junit4]   2> 5129170 T11771 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
   [junit4]   2> 5129171 T11771 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
   [junit4]   2> 5129177 T11771 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml
   [junit4]   2> 5129178 T11771 oascc.SolrZkClient.makePath makePath: /configs/conf1/enumsConfig.xml
   [junit4]   2> 5129185 T11771 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 5129185 T11771 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
   [junit4]   2> 5129192 T11771 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 5129192 T11771 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 5129199 T11771 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
   [junit4]   2> 5129199 T11771 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
   [junit4]   2> 5129205 T11771 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
   [junit4]   2> 5129205 T11771 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
   [junit4]   2> Using new style solr.xml
   [junit4]   2> 5131237 T11771 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 5131246 T11771 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:60002
   [junit4]   2> 5131249 T11771 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 5131249 T11771 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 5131250 T11771 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-002
   [junit4]   2> 5131250 T11771 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-002/'
   [junit4]   2> 5131315 T11771 oasc.ConfigSolr.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-002/solr.xml
   [junit4]   2> 5131386 T11771 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-002
   [junit4]   2> 5131387 T11771 oasc.CoreContainer.<init> New CoreContainer 993983052
   [junit4]   2> 5131387 T11771 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-002/]
   [junit4]   2> 5131388 T11771 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
   [junit4]   2> 5131389 T11771 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: 
   [junit4]   2> 5131389 T11771 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 5131389 T11771 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 5131390 T11771 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
   [junit4]   2> 5131390 T11771 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 5131390 T11771 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 5131391 T11771 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 5131391 T11771 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 5131391 T11771 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 5131392 T11771 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 5131392 T11771 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 5131393 T11771 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 5131393 T11771 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 5131393 T11771 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:59999/solr
   [junit4]   2> 5131394 T11771 oasc.ZkController.checkChrootPath zkHost includes chroot
   [junit4]   2> 5131395 T11771 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
   [junit4]   2> 5131396 T11771 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 5131400 T11794 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@37424e65 name:ZooKeeperConnection Watcher:127.0.0.1:59999 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 5131402 T11771 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 5131402 T11771 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
   [junit4]   2> 5131408 T11771 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 5131412 T11797 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@2a1ead7c name:ZooKeeperConnection Watcher:127.0.0.1:59999/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 5131412 T11771 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 5131416 T11771 oascc.SolrZkClient.makePath makePath: /overseer/queue
   [junit4]   2> 5131424 T11771 oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work
   [junit4]   2> 5131433 T11771 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-running
   [junit4]   2> 5131444 T11771 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-completed
   [junit4]   2> 5131453 T11771 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-failure
   [junit4]   2> 5131464 T11771 oascc.SolrZkClient.makePath makePath: /live_nodes
   [junit4]   2> 5131469 T11771 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60002_
   [junit4]   2> 5131470 T11771 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:60002_
   [junit4]   2> 5131479 T11771 oascc.SolrZkClient.makePath makePath: /overseer_elect
   [junit4]   2> 5131485 T11771 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
   [junit4]   2> 5131493 T11771 oasc.Overseer.close Overseer (id=null) closing
   [junit4]   2> 5131501 T11771 oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader 127.0.0.1:60002_
   [junit4]   2> 5131502 T11771 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
   [junit4]   2> 5131512 T11771 oasc.Overseer.start Overseer (id=92847270637207555-127.0.0.1:60002_-n_0000000000) starting
   [junit4]   2> 5131520 T11771 oascc.SolrZkClient.makePath makePath: /overseer/queue-work
   [junit4]   2> 5131556 T11771 oasc.OverseerAutoReplicaFailoverThread.<init> Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=10000 autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 5131559 T11799 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
   [junit4]   2> 5131562 T11771 oascc.SolrZkClient.makePath makePath: /clusterstate.json
   [junit4]   2> 5131571 T11771 oascc.SolrZkClient.makePath makePath: /aliases.json
   [junit4]   2> 5131576 T11771 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 5131598 T11798 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
   [junit4]   2> 5131946 T11771 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-002
   [junit4]   2> 5132617 T11771 oasc.CorePropertiesLocator.discoverUnder Found core conf in /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-002/conf/
   [junit4]   2> 5132722 T11771 oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 5132725 T11771 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0
   [junit4]   2> 5132726 T11771 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 5132727 T11771 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
   [junit4]   2> 5132728 T11771 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 5132735 T11804 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@64cde597 name:ZooKeeperConnection Watcher:127.0.0.1:59999/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 5132736 T11771 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 5132736 T11771 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
   [junit4]   2> 5132741 T11771 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 5132753 T11771 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:false cause connection loss:false
   [junit4]   2> 5132753 T11771 oasc.AbstractFullDistribZkTestBase.createJettys Creating collection1 with stateFormat=2
   [junit4]   2> 5132754 T11771 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
   [junit4]   2> 5132756 T11771 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 5132764 T11807 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@5f4d34b1 name:ZooKeeperConnection Watcher:127.0.0.1:59999/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 5132765 T11771 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 5132765 T11771 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
   [junit4]   2> 5132775 T11797 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 5132791 T11798 oasc.Overseer$ClusterStateUpdater.buildCollection building a new collection: collection1
   [junit4]   2> 5132791 T11798 oasc.Overseer$ClusterStateUpdater.createCollection Create collection collection1 with shards [shard1, shard2]
   [junit4]   2> 5132792 T11798 oasc.Overseer$ClusterStateUpdater.createCollection state version collection1 2
   [junit4]   2> 5132805 T11798 oasc.Overseer$ClusterStateUpdater.updateZkStates going to create_collection /collections/collection1/state.json
   [junit4]   2> 5132811 T11797 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 5132812 T11804 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 5134452 T11771 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 1
   [junit4]   2> 5134453 T11771 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 5134459 T11771 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:60007
   [junit4]   2> 5134461 T11771 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 5134461 T11771 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 5134462 T11771 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003
   [junit4]   2> 5134462 T11771 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003/'
   [junit4]   2> 5134517 T11771 oasc.ConfigSolr.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003/solr.xml
   [junit4]   2> 5134576 T11771 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003
   [junit4]   2> 5134576 T11771 oasc.CoreContainer.<init> New CoreContainer 231261936
   [junit4]   2> 5134577 T11771 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003/]
   [junit4]   2> 5134578 T11771 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
   [junit4]   2> 5134579 T11771 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: 
   [junit4]   2> 5134579 T11771 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 5134579 T11771 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 5134580 T11771 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
   [junit4]   2> 5134580 T11771 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 5134580 T11771 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 5134581 T11771 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 5134581 T11771 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 5134582 T11771 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 5134582 T11771 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 5134583 T11771 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 5134583 T11771 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 5134583 T11771 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 5134583 T11771 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:59999/solr
   [junit4]   2> 5134584 T11771 oasc.ZkController.checkChrootPath zkHost includes chroot
   [junit4]   2> 5134584 T11771 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
   [junit4]   2> 5134586 T11771 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 5134589 T11819 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@733de998 name:ZooKeeperConnection Watcher:127.0.0.1:59999 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 5134591 T11771 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 5134591 T11771 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
   [junit4]   2> 5134598 T11771 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 5134603 T11822 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@239931b1 name:ZooKeeperConnection Watcher:127.0.0.1:59999/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 5134603 T11771 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 5134624 T11771 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 5135644 T11771 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60007_
   [junit4]   2> 5135649 T11771 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:60007_
   [junit4]   2> 5135664 T11771 oasc.Overseer.close Overseer (id=null) closing
   [junit4]   2> 5135674 T11771 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003
   [junit4]   2> 5136612 T11771 oasc.CorePropertiesLocator.discoverUnder Found core conf in /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003/conf/
   [junit4]   2> 5136735 T11771 oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 5136738 T11771 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0
   [junit4]   2> 5136739 T11771 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 5138646 T11771 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 2
   [junit4]   2> 5138647 T11771 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 5138654 T11771 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:60010
   [junit4]   2> 5138656 T11771 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 5138657 T11771 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 5138657 T11771 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004
   [junit4]   2> 5138658 T11771 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004/'
   [junit4]   2> 5138718 T11771 oasc.ConfigSolr.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004/solr.xml
   [junit4]   2> 5138788 T11771 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004
   [junit4]   2> 5138789 T11771 oasc.CoreContainer.<init> New CoreContainer 168340062
   [junit4]   2> 5138789 T11771 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004/]
   [junit4]   2> 5138791 T11771 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
   [junit4]   2> 5138791 T11771 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: 
   [junit4]   2> 5138792 T11771 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 5138792 T11771 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 5138793 T11771 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
   [junit4]   2> 5138793 T11771 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 5138794 T11771 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 5138795 T11771 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 5138796 T11771 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 5138797 T11771 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 5138797 T11771 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 5138798 T11771 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 5138799 T11771 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 5138800 T11771 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 5138800 T11771 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:59999/solr
   [junit4]   2> 5138802 T11771 oasc.ZkController.checkChrootPath zkHost includes chroot
   [junit4]   2> 5138803 T11771 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
   [junit4]   2> 5138805 T11771 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 5138808 T11835 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@403a0e7b name:ZooKeeperConnection Watcher:127.0.0.1:59999 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 5138810 T11771 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 5138811 T11771 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
   [junit4]   2> 5138820 T11771 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 5138825 T11838 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@67c0715a name:ZooKeeperConnection Watcher:127.0.0.1:59999/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 5138826 T11771 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 5138850 T11771 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 5139871 T11771 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60010_
   [junit4]   2> 5139874 T11771 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:60010_
   [junit4]   2> 5139895 T11771 oasc.Overseer.close Overseer (id=null) closing
   [junit4]   2> 5139910 T11771 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004
   [junit4]   2> 5140586 T11771 oasc.CorePropertiesLocator.discoverUnder Found core conf in /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004/conf/
   [junit4]   2> 5140693 T11771 oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 5140695 T11771 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0
   [junit4]   2> 5140696 T11771 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 5142538 T11771 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 3
   [junit4]   2> 5142539 T11771 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 5142545 T11771 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:60013
   [junit4]   2> 5142548 T11771 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 5142548 T11771 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 5142548 T11771 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005
   [junit4]   2> 5142549 T11771 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005/'
   [junit4]   2> 5142605 T11771 oasc.ConfigSolr.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005/solr.xml
   [junit4]   2> 5142658 T11771 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005
   [junit4]   2> 5142658 T11771 oasc.CoreContainer.<init> New CoreContainer 1843400362
   [junit4]   2> 5142659 T11771 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005/]
   [junit4]   2> 5142660 T11771 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
   [junit4]   2> 5142660 T11771 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: 
   [junit4]   2> 5142661 T11771 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 5142661 T11771 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 5142662 T11771 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
   [junit4]   2> 5142662 T11771 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 5142662 T11771 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 5142663 T11771 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 5142663 T11771 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 5142663 T11771 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 5142664 T11771 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 5142664 T11771 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 5142664 T11771 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 5142665 T11771 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 5142666 T11771 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:59999/solr
   [junit4]   2> 5142666 T11771 oasc.ZkController.checkChrootPath zkHost includes chroot
   [junit4]   2> 5142666 T11771 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
   [junit4]   2> 5142668 T11771 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 5142674 T11851 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@3c7cd00c name:ZooKeeperConnection Watcher:127.0.0.1:59999 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 5142675 T11771 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 5142677 T11771 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
   [junit4]   2> 5142684 T11771 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 5142690 T11854 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@23514650 name:ZooKeeperConnection Watcher:127.0.0.1:59999/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 5142690 T11771 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 5142716 T11771 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 5143740 T11771 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60013_
   [junit4]   2> 5143744 T11771 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:60013_
   [junit4]   2> 5143766 T11771 oasc.Overseer.close Overseer (id=null) closing
   [junit4]   2> 5143776 T11771 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005
   [junit4]   2> 5144519 T11771 oasc.CorePropertiesLocator.discoverUnder Found core conf in /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005/conf/
   [junit4]   2> 5144622 T11771 oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 5144625 T11771 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0
   [junit4]   2> 5144626 T11771 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 5146597 T11771 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 4
   [junit4]   2> 5146598 T11771 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 5146605 T11771 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:60016
   [junit4]   2> 5146608 T11771 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 5146608 T11771 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 5146609 T11771 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-006
   [junit4]   2> 5146609 T11771 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-006/'
   [junit4]   2> 5146661 T11771 oasc.ConfigSolr.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-006/solr.xml
   [junit4]   2> 5146732 T11771 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-006
   [junit4]   2> 5146732 T11771 oasc.CoreContainer.<init> New CoreContainer 1300781065
   [junit4]   2> 5146732 T11771 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-006/]
   [junit4]   2> 5146734 T11771 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
   [junit4]   2> 5146735 T11771 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: 
   [junit4]   2> 5146735 T11771 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 5146736 T11771 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 5146736 T11771 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
   [junit4]   2> 5146736 T11771 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 5146736 T11771 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 5146737 T11771 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 5146737 T11771 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 5146737 T11771 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 5146737 T11771 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 5146738 T11771 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 5146739 T11771 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 5146739 T11771 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 5146739 T11771 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:59999/solr
   [junit4]   2> 5146740 T11771 oasc.ZkController.checkChrootPath zkHost includes chroot
   [junit4]   2> 5146740 T11771 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
   [junit4]   2> 5146741 T11771 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 5146746 T11867 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@64bb7ee8 name:ZooKeeperConnection Watcher:127.0.0.1:59999 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 5146749 T11771 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 5146750 T11771 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
   [junit4]   2> 5146764 T11771 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 5146770 T11870 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@720805 name:ZooKeeperConnection Watcher:127.0.0.1:59999/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 5146771 T11771 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 5146791 T11771 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 5147813 T11771 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60016_
   [junit4]   2> 5147818 T11771 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:60016_
   [junit4]   2> 5147842 T11771 oasc.Overseer.close Overseer (id=null) closing
   [junit4]   2> 5147858 T11771 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-006
   [junit4]   2> 5148724 T11771 oasc.CorePropertiesLocator.discoverUnder Found core conf in /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-006/conf/
   [junit4]   2> 5148829 T11771 oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 5148832 T11771 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0
   [junit4]   2> 5148833 T11771 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 5148843 T11815 oasha.CollectionsHandler.handleCreateAction Creating Collection : name=solrj_collection&numShards=2&version=2&action=CREATE&replicationFactor=2&wt=javabin&router.field=myOwnField&collection.configName=conf1
   [junit4]   2> 5148845 T11797 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/collection-queue-work state SyncConnected
   [junit4]   2> 5148848 T11799 oasc.OverseerCollectionProcessor.run Overseer Collection Processor: Get the message id:/overseer/collection-queue-work/qn-0000000000 message:{
   [junit4]   2> 	  "operation":"create",
   [junit4]   2> 	  "fromApi":"true",
   [junit4]   2> 	  "name":"solrj_collection",
   [junit4]   2> 	  "replicationFactor":"2",
   [junit4]   2> 	  "collection.configName":"conf1",
   [junit4]   2> 	  "numShards":"2",
   [junit4]   2> 	  "router.field":"myOwnField"}
   [junit4]   2> 5148852 T11872 oasc.OverseerCollectionProcessor.processMessage WARN OverseerCollectionProcessor.processMessage : create , {
   [junit4]   2> 	  "operation":"create",
   [junit4]   2> 	  "fromApi":"true",
   [junit4]   2> 	  "name":"solrj_collection",
   [junit4]   2> 	  "replicationFactor":"2",
   [junit4]   2> 	  "collection.configName":"conf1",
   [junit4]   2> 	  "numShards":"2",
   [junit4]   2> 	  "router.field":"myOwnField"}
   [junit4]   2> 5148854 T11872 oasc.OverseerCollectionProcessor.createConfNode creating collections conf node /collections/solrj_collection 
   [junit4]   2> 5148855 T11872 oascc.SolrZkClient.makePath makePath: /collections/solrj_collection
   [junit4]   2> 5148866 T11797 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 5148877 T11798 oasc.Overseer$ClusterStateUpdater.buildCollection building a new collection: solrj_collection
   [junit4]   2> 5148878 T11798 oasc.Overseer$ClusterStateUpdater.createCollection Create collection solrj_collection with shards [shard1, shard2]
   [junit4]   2> 5148878 T11798 oasc.Overseer$ClusterStateUpdater.createCollection state version solrj_collection 1
   [junit4]   2> 5148887 T11804 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
   [junit4]   2> 5148887 T11854 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
   [junit4]   2> 5148888 T11838 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
   [junit4]   2> 5148888 T11870 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
   [junit4]   2> 5148888 T11822 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
   [junit4]   2> 5148887 T11797 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
   [junit4]   2> 5148967 T11872 oasc.OverseerCollectionProcessor.createCollection Creating SolrCores for new collection solrj_collection, shardNames [shard1, shard2] , replicationFactor : 2
   [junit4]   2> 5148967 T11872 oasc.OverseerCollectionProcessor.createCollection Creating shard solrj_collection_shard1_replica1 as part of slice shard1 of collection solrj_collection on 127.0.0.1:60007_
   [junit4]   2> 5148969 T11872 oasc.OverseerCollectionProcessor.createCollection Creating shard solrj_collection_shard1_replica2 as part of slice shard1 of collection solrj_collection on 127.0.0.1:60013_
   [junit4]   2> 5148972 T11872 oasc.OverseerCollectionProcessor.createCollection Creating shard solrj_collection_shard2_replica1 as part of slice shard2 of collection solrj_collection on 127.0.0.1:60016_
   [junit4]   2> 5148976 T11810 oasha.CoreAdminHandler.handleCreateAction core create command name=solrj_collection_shard1_replica1&collection=solrj_collection&numShards=2&version=2&action=CREATE&wt=javabin&qt=/admin/cores&shard=shard1&collection.configName=conf1
   [junit4]   2> 5148978 T11847 oasha.CoreAdminHandler.handleCreateAction core create command name=solrj_collection_shard1_replica2&collection=solrj_collection&numShards=2&version=2&action=CREATE&wt=javabin&qt=/admin/cores&shard=shard1&collection.configName=conf1
   [junit4]   2> 5148980 T11872 oasc.OverseerCollectionProcessor.createCollection Creating shard solrj_collection_shard2_replica2 as part of slice shard2 of collection solrj_collection on 127.0.0.1:60010_
   [junit4]   2> 5148983 T11810 oasc.ZkController.publish publishing core=solrj_collection_shard1_replica1 state=down collection=solrj_collection
   [junit4]   2> 5148984 T11864 oasha.CoreAdminHandler.handleCreateAction core create command name=solrj_collection_shard2_replica1&collection=solrj_collection&numShards=2&version=2&action=CREATE&wt=javabin&qt=/admin/cores&shard=shard2&collection.configName=conf1
   [junit4]   2> 5148986 T11810 oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 5148986 T11847 oasc.ZkController.publish publishing core=solrj_collection_shard1_replica2 state=down collection=solrj_collection
   [junit4]   2> 5148988 T11797 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 5148989 T11847 oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 5148989 T11864 oasc.ZkController.publish publishing core=solrj_collection_shard2_replica1 state=down collection=solrj_collection
   [junit4]   2> 5148991 T11864 oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 5148994 T11832 oasha.CoreAdminHandler.handleCreateAction core create command name=solrj_collection_shard2_replica2&collection=solrj_collection&numShards=2&version=2&action=CREATE&wt=javabin&qt=/admin/cores&shard=shard2&collection.configName=conf1
   [junit4]   2> 5148997 T11832 oasc.ZkController.publish publishing core=solrj_collection_shard2_replica2 state=down collection=solrj_collection
   [junit4]   2> 5148999 T11832 oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 5149002 T11798 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
   [junit4]   2> 	  "base_url":"http://127.0.0.1:60007",
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "collection":"solrj_collection",
   [junit4]   2> 	  "numShards":"2",
   [junit4]   2> 	  "core":"solrj_collection_shard1_replica1",
   [junit4]   2> 	  "state":"down",
   [junit4]   2> 	  "node_name":"127.0.0.1:60007_",
   [junit4]   2> 	  "roles":null,
   [junit4]   2> 	  "shard":"shard1"}
   [junit4]   2> 5149010 T11798 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
   [junit4]   2> 	  "base_url":"http://127.0.0.1:60013",
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "collection":"solrj_collection",
   [junit4]   2> 	  "numShards":"2",
   [junit4]   2> 	  "core":"solrj_collection_shard1_replica2",
   [junit4]   2> 	  "state":"down",
   [junit4]   2> 	  "node_name":"127.0.0.1:60013_",
   [junit4]   2> 	  "roles":null,
   [junit4]   2> 	  "shard":"shard1"}
   [junit4]   2> 5149016 T11797 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 5149018 T11798 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
   [junit4]   2> 	  "base_url":"http://127.0.0.1:60016",
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "collection":"solrj_collection",
   [junit4]   2> 	  "numShards":"2",
   [junit4]   2> 	  "core":"solrj_collection_shard2_replica1",
   [junit4]   2> 	  "state":"down",
   [junit4]   2> 	  "node_name":"127.0.0.1:60016_",
   [junit4]   2> 	  "roles":null,
   [junit4]   2> 	  "shard":"shard2"}
   [junit4]   2> 5149026 T11798 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
   [junit4]   2> 	  "base_url":"http://127.0.0.1:60010",
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "collection":"solrj_collection",
   [junit4]   2> 	  "numShards":"2",
   [junit4]   2> 	  "core":"solrj_collection_shard2_replica2",
   [junit4]   2> 	  "state":"down",
   [junit4]   2> 	  "node_name":"127.0.0.1:60010_",
   [junit4]   2> 	  "roles":null,
   [junit4]   2> 	  "shard":"shard2"}
   [junit4]   2> 5149032 T11797 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 5149136 T11870 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
   [junit4]   2> 5149137 T11804 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
   [junit4]   2> 5149138 T11854 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
   [junit4]   2> 5149137 T11838 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
   [junit4]   2> 5149138 T11822 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
   [junit4]   2> 5149140 T11797 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
   [junit4]   2> 5149987 T11810 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for solrj_collection_shard1_replica1
   [junit4]   2> 5149988 T11810 oasc.ZkController.createCollectionZkNode Check for collection zkNode:solrj_collection
   [junit4]   2> 5149989 T11847 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for solrj_collection_shard1_replica2
   [junit4]   2> 5149990 T11847 oasc.ZkController.createCollectionZkNode Check for collection zkNode:solrj_collection
   [junit4]   2> 5149991 T11810 oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 5149991 T11810 oascc.ZkStateReader.readConfigName Load collection config from:/collections/solrj_collection
   [junit4]   2> 5149992 T11864 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for solrj_collection_shard2_replica1
   [junit4]   2> 5149993 T11864 oasc.ZkController.createCollectionZkNode Check for collection zkNode:solrj_collection
   [junit4]   2> 5149994 T11847 oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 5149994 T11847 oascc.ZkStateReader.readConfigName Load collection config from:/collections/solrj_collection
   [junit4]   2> 5149998 T11864 oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 5149999 T11864 oascc.ZkStateReader.readConfigName Load collection config from:/collections/solrj_collection
   [junit4]   2> 5150002 T11832 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for solrj_collection_shard2_replica2
   [junit4]   2> 5150002 T11832 oasc.ZkController.createCollectionZkNode Check for collection zkNode:solrj_collection
   [junit4]   2> 5150002 T11810 oascc.ZkStateReader.readConfigName path=/collections/solrj_collection configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 5150004 T11847 oascc.ZkStateReader.readConfigName path=/collections/solrj_collection configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 5150004 T11847 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005/solrj_collection_shard1_replica2/'
   [junit4]   2> 5150004 T11810 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003/solrj_collection_shard1_replica1/'
   [junit4]   2> 5150007 T11864 oascc.ZkStateReader.readConfigName path=/collections/solrj_collection configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 5150008 T11864 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-006/solrj_collection_shard2_replica1/'
   [junit4]   2> 5150015 T11832 oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 5150015 T11832 oascc.ZkStateReader.readConfigName Load collection config from:/collections/solrj_collection
   [junit4]   2> 5150038 T11832 oascc.ZkStateReader.readConfigName path=/collections/solrj_collection configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 5150039 T11832 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004/solrj_collection_shard2_replica2/'
   [junit4]   2> 5150253 T11832 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
   [junit4]   2> 5150258 T11847 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
   [junit4]   2> 5150282 T11810 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
   [junit4]   2> 5150286 T11864 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
   [junit4]   2> 5150420 T11832 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 5150431 T11847 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 5150434 T11864 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 5150435 T11832 oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml
   [junit4]   2> 5150439 T11864 oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml
   [junit4]   2> 5150449 T11847 oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml
   [junit4]   2> 5150453 T11810 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 5150459 T11847 oass.IndexSchema.readSchema [solrj_collection_shard1_replica2] Schema name=test
   [junit4]   2> 5150464 T11810 oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml
   [junit4]   2> 5150472 T11832 oass.IndexSchema.readSchema [solrj_collection_shard2_replica2] Schema name=test
   [junit4]   2> 5150477 T11810 oass.IndexSchema.readSchema [solrj_collection_shard1_replica1] Schema name=test
   [junit4]   2> 5150518 T11864 oass.IndexSchema.readSchema [solrj_collection_shard2_replica1] Schema name=test
   [junit4]   2> 5151598 T11847 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 5151655 T11847 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 5151659 T11847 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 5151691 T11810 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 5151704 T11832 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 5151709 T11810 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 5151736 T11810 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 5151737 T11832 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 5151742 T11832 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 5151769 T11864 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 5151805 T11847 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 5151807 T11810 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 5151818 T11847 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 5151822 T11810 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 5151825 T11847 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 5151827 T11832 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 5151832 T11847 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 5151843 T11847 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 5151847 T11847 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 5151834 T11864 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 5151850 T11832 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 5151851 T11810 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 5151852 T11864 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 5151853 T11810 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 5151854 T11810 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 5151854 T11810 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 5151856 T11847 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 5151856 T11847 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 5151865 T11847 oasc.CoreContainer.create Creating SolrCore 'solrj_collection_shard1_replica2' using configuration from collection solrj_collection
   [junit4]   2> 5151865 T11847 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 5151858 T11810 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 5151867 T11810 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 5151869 T11810 oasc.CoreContainer.create Creating SolrCore 'solrj_collection_shard1_replica1' using configuration from collection solrj_collection
   [junit4]   2> 5151866 T11847 oasc.SolrCore.<init> [solrj_collection_shard1_replica2] Opening new SolrCore at /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005/solrj_collection_shard1_replica2/, dataDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005/solrj_collection_shard1_replica2/data/
   [junit4]   2> 5151870 T11847 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@2dab769e
   [junit4]   2> 5151869 T11810 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 5151865 T11832 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 5151872 T11847 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005/solrj_collection_shard1_replica2/data
   [junit4]   2> 5151876 T11847 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005/solrj_collection_shard1_replica2/data/index/
   [junit4]   2> 5151876 T11847 oasc.SolrCore.initIndex WARN [solrj_collection_shard1_replica2] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005/solrj_collection_shard1_replica2/data/index' doesn't exist. Creating new index...
   [junit4]   2> 5151876 T11832 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 5151878 T11847 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-005/solrj_collection_shard1_replica2/data/index
   [junit4]   2> 5151881 T11847 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=46, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=14.9384765625, floorSegmentMB=0.8671875, forceMergeDeletesPctAllowed=0.023491033878365597, segmentsPerTier=20.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 5151879 T11810 oasc.SolrCore.<init> [solrj_collection_shard1_replica1] Opening new SolrCore at ../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003/solrj_collection_shard1_replica1/, dataDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003/solrj_collection_shard1_replica1/data/
   [junit4]   2> 5151883 T11810 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@2dab769e
   [junit4]   2> 5151878 T11832 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 5151885 T11832 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 5151885 T11810 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003/solrj_collection_shard1_replica1/data
   [junit4]   2> 5151887 T11810 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003/solrj_collection_shard1_replica1/data/index/
   [junit4]   2> 5151887 T11810 oasc.SolrCore.initIndex WARN [solrj_collection_shard1_replica1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003/solrj_collection_shard1_replica1/data/index' doesn't exist. Creating new index...
   [junit4]   2> 5151888 T11810 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-003/solrj_collection_shard1_replica1/data/index
   [junit4]   2> 5151888 T11847 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@696704f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ea755e9),segFN=segments_1,generation=1}
   [junit4]   2> 5151890 T11847 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 5151891 T11810 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=46, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=14.9384765625, floorSegmentMB=0.8671875, forceMergeDeletesPctAllowed=0.023491033878365597, segmentsPerTier=20.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 5151892 T11810 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@d14eb26 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@585a127f),segFN=segments_1,generation=1}
   [junit4]   2> 5151892 T11810 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 5151895 T11832 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 5151895 T11832 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 5151896 T11832 oasc.CoreContainer.create Creating SolrCore 'solrj_collection_shard2_replica2' using configuration from collection solrj_collection
   [junit4]   2> 5151896 T11832 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 5151897 T11832 oasc.SolrCore.<init> [solrj_collection_shard2_replica2] Opening new SolrCore at /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004/solrj_collection_shard2_replica2/, dataDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004/solrj_collection_shard2_replica2/data/
   [junit4]   2> 5151898 T11832 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@2dab769e
   [junit4]   2> 5151899 T11832 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004/solrj_collection_shard2_replica2/data
   [junit4]   2> 5151900 T11832 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004/solrj_collection_shard2_replica2/data/index/
   [junit4]   2> 5151902 T11832 oasc.SolrCore.initIndex WARN [solrj_collection_shard2_replica2] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004/solrj_collection_shard2_replica2/data/index' doesn't exist. Creating new index...
   [junit4]   2> 5151903 T11832 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-004/solrj_collection_shard2_replica2/data/index
   [junit4]   2> 5151903 T11832 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=46, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=14.9384765625, floorSegmentMB=0.8671875, forceMergeDeletesPctAllowed=0.023491033878365597, segmentsPerTier=20.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 5151904 T11832 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@1d898849 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@30527fc5),segFN=segments_1,generation=1}
   [junit4]   2> 5151905 T11832 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 5151901 T11847 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
   [junit4]   2> 5151907 T11847 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 5151908 T11847 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 5151908 T11847 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 5151908 T11847 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 5151908 T11847 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 5151909 T11847 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 5151909 T11847 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 5151910 T11847 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 5151911 T11847 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 5151911 T11847 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 5151912 T11847 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 5151913 T11847 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 5151913 T11847 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
   [junit4]   2> 5151914 T11847 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 5151915 T11847 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
   [junit4]   2> 5151912 T11832 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
   [junit4]   2> 5151918 T11864 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 5151920 T11847 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 5151922 T11847 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 5151913 T11810 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
   [junit4]   2> 5151919 T11832 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 5151923 T11847 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 5151925 T11847 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler
   [junit4]   2> 5151924 T11832 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 5151929 T11832 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 5151929 T11832 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 5151930 T11832 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 5151930 T11832 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 5151931 T11832 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 5151931 T11832 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 5151932 T11832 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 5151933 T11832 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 5151933 T11832 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 5151934 T11832 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 5151935 T11832 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
   [junit4]   2> 5151935 T11832 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 5151936 T11832 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
   [junit4]   2> 5151937 T11832 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 5151938 T11832 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 5151939 T11832 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 5151939 T11832 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler
   [junit4]   2> 5151940 T11864 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 5151940 T11810 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 5151945 T11810 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 5151945 T11810 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 5151946 T11847 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 5151947 T11832 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 5151948 T11847 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 5151949 T11832 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 5151946 T11810 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 5151950 T11810 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 5151954 T11810 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 5151954 T11810 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 5151955 T11810 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 5151949 T11847 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 5151962 T11847 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 5151963 T11864 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 5151958 T11810 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 5151966 T11810 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 5151954 T11832 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 5151968 T11810 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 5151971 T11832 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 5151973 T11847 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 5151973 T11847 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 5151974 T11847 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=20, maxMergeAtOnceExplicit=22, maxMergedSegmentMB=25.2314453125, floorSegmentMB=0.75390625, forceMergeDeletesPctAllowed=0.05507263694569886, segmentsPerTier=35.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7172019855143539
   [junit4]   2> 5151974 T11810 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 5151975 T11810 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
   [junit4]   2> 5151981 T11810 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 5151981 T11810 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
   [junit4]   2> 5151982 T11810 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 5151980 T11832 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 5151983 T11832 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 5151975 T11864 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 5151984 T11864 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 5151984 T11864 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 5151984 T11832 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=20, maxMergeAtOnceExplicit=22, maxMergedSegmentMB=25.2314453125, floorSegmentMB=0.75390625, forceMergeDeletesPctAllowed=0.05507263694569886, segmentsPerTier=35.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7172019855143539
   [junit4]   2> 5151983 T11810 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 5151981 T11847 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@696704f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ea755e9),segFN=segments_1,generation=1}
   [junit4]   2> 5151987 T11847 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 5151989 T11847 oass.SolrIndexSearcher.<init> Opening Searcher@a48622a[solrj_collection_shard1_replica2] main
   [junit4]   2> 5151990 T11847 oascc.ZkStateReader.readConfigName Load collection config from:/collections/solrj_collection
   [junit4]   2> 5151988 T11832 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@1d898849 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@30527fc5),segFN=segments_1,generation=1}
   [junit4]   2> 5151991 T11832 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 5151991 T11832 oass.SolrIndexSearcher.<init> Opening Searcher@44d82f8f[solrj_collection_shard2_replica2] main
   [junit4]   2> 5151991 T11832 oascc.ZkStateReader.readConfigName Load collection config from:/collections/solrj_collection
   [junit4]   2> 5151992 T11847 oascc.ZkStateReader.readConfigName path=/collections/solrj_collection configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 5151993 T11847 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
   [junit4]   2> 5151988 T11864 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 5151995 T11847 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 5151995 T11847 oasr.RestManager.init Initializing RestManager with initArgs: {}
   [junit4]   2> 5151996 T11847 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 5151987 T11810 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 5151997 T11847 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found for znode /configs/conf1/_rest_managed.json
   [junit4]   2> 5151997 T11847 oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 5151995 T11864 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 5151999 T11864 oasc.CoreContainer.create Creating

[...truncated too long message...]

T11771 oasc.CachingDirectoryFactory.close Closing directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001/tempDir-006/nodes_used_collection_shard2_replica1/data/index
   [junit4]   2> 5253111 T11771 oasc.Overseer.close Overseer (id=92847270637207565-127.0.0.1:60016_-n_0000000004) closing
   [junit4]   2> 5253112 T11995 oasc.Overseer$ClusterStateUpdater.run Overseer Loop exiting : 127.0.0.1:60016_
   [junit4]   2> 5253119 T11959 oascc.ZkStateReader$3.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
   [junit4]   2> 5253139 T11771 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/,null}
   [junit4]   2> 5258121 T11771 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
   [junit4]   2> 5258125 T11771 oasc.ZkTestServer.send4LetterWord connecting to 127.0.0.1:59999 59999
   [junit4]   2> 5258130 T11971 oasc.ZkTestServer.send4LetterWord connecting to 127.0.0.1:59999 59999
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=CollectionsAPIDistributedZkTest -Dtests.method=testDistribSearch -Dtests.seed=B2E40A0D454A5104 -Dtests.slow=true -Dtests.locale=en_IN -Dtests.timezone=Asia/Irkutsk -Dtests.asserts=false -Dtests.file.encoding=US-ASCII
   [junit4] FAILURE  130s | CollectionsAPIDistributedZkTest.testDistribSearch <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: some core start times did not change on reload
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([B2E40A0D454A5104:3302841532153138]:0)
   [junit4]    > 	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testCollectionsAPI(CollectionsAPIDistributedZkTest.java:884)
   [junit4]    > 	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.doTest(CollectionsAPIDistributedZkTest.java:203)
   [junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 5258831 T11771 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-B2E40A0D454A5104-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene50): {id=PostingsFormat(name=LuceneFixedGap), range_facet_l=PostingsFormat(name=LuceneVarGapFixedInterval), multiDefault=PostingsFormat(name=Memory doPackFST= true), text=PostingsFormat(name=Direct), intDefault=PostingsFormat(name=LuceneVarGapFixedInterval), other_tl1=PostingsFormat(name=LuceneVarGapFixedInterval), a_i1=PostingsFormat(name=LuceneVarGapFixedInterval), a_t=PostingsFormat(name=LuceneVarGapFixedInterval), timestamp=PostingsFormat(name=LuceneVarGapFixedInterval), _version_=PostingsFormat(name=LuceneVarGapFixedInterval)}, docValues:{timestamp=DocValuesFormat(name=Lucene50)}, sim=DefaultSimilarity, locale=en_IN, timezone=Asia/Irkutsk
   [junit4]   2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.7.0_67 (64-bit)/cpus=2,threads=1,free=180811296,total=336039936
   [junit4]   2> NOTE: All tests run in this JVM: [AlternateDirectoryTest, TestHashPartitioner, TestManagedSchemaDynamicFieldResource, TestWordDelimiterFilterFactory, TestSolrCoreProperties, TestModifyConfFiles, DateMathParserTest, TestComponentsName, XsltUpdateRequestHandlerTest, ResponseLogComponentTest, TestReplicationHandler, TestFaceting, BJQParserTest, HdfsChaosMonkeySafeLeaderTest, BinaryUpdateRequestHandlerTest, MoreLikeThisHandlerTest, CircularListTest, TestCoreContainer, TestSolrQueryParser, TestDocumentBuilder, TestCharFilters, TestRandomMergePolicy, TestRestManager, PeerSyncTest, TestSchemaResource, TestHighFrequencyDictionaryFactory, DistributedFacetPivotSmallTest, BadIndexSchemaTest, TestDefaultSearchFieldResource, SpellCheckCollatorTest, SharedFSAutoReplicaFailoverTest, FileUtilsTest, ExitableDirectoryReaderTest, JSONWriterTest, TestAnalyzedSuggestions, HardAutoCommitTest, FacetPivotSmallTest, DistributedQueueTest, CoreAdminCreateDiscoverTest, SolrIndexSplitterTest, HdfsBasicDistributedZkTest, HttpPartitionTest, SimplePostToolTest, TestFieldTypeResource, TestFreeTextSuggestions, OverseerRolesTest, SOLR749Test, SuggesterTest, TestSweetSpotSimilarityFactory, DOMUtilTest, TestCloudManagedSchema, TestZkChroot, FileBasedSpellCheckerTest, TriLevelCompositeIdRoutingTest, WordBreakSolrSpellCheckerTest, QueryParsingTest, ExternalFileFieldSortTest, TestRequestStatusCollectionAPI, SolrRequestParserTest, CacheHeaderTest, DistributedIntervalFacetingTest, DirectSolrSpellCheckerTest, TestSchemaSimilarityResource, MergeStrategyTest, TestReplicaProperties, TestCSVResponseWriter, AnalysisAfterCoreReloadTest, HighlighterMaxOffsetTest, HdfsBasicDistributedZk2Test, TermVectorComponentTest, TestManagedSchemaFieldResource, RequestHandlersTest, CoreAdminHandlerTest, TestOrdValues, ShardRoutingTest, TestBlendedInfixSuggestions, TestSolrDynamicMBean, TestRangeQuery, SolrXmlInZkTest, StatelessScriptUpdateProcessorFactoryTest, AnalyticsMergeStrategyTest, TestDistributedSearch, SyncSliceTest, TestWriterPerf, ClusterStateTest, TestShortCircuitedRequests, TestDistributedMissingSort, TestInitQParser, TestOverriddenPrefixQueryForCustomFieldType, TestNRTOpen, QueryResultKeyTest, TestFastLRUCache, ShardSplitTest, SolrPluginUtilsTest, ChaosMonkeySafeLeaderTest, CloudMLTQParserTest, TestQuerySenderNoQuery, AnalysisErrorHandlingTest, FieldAnalysisRequestHandlerTest, UUIDFieldTest, TestStressUserVersions, TestCollectionAPI, TestFieldSortValues, TestSolrXml, RankQueryTest, TestDocSet, TestDynamicFieldCollectionResource, CloudExitableDirectoryReaderTest, LeaderInitiatedRecoveryOnCommitTest, TestSearchPerf, TestCustomSort, CurrencyFieldOpenExchangeTest, URLClassifyProcessorTest, TestOmitPositions, TestUpdate, EnumFieldTest, VMParamsZkACLAndCredentialsProvidersTest, TermsComponentTest, ResourceLoaderTest, TestSolr4Spatial2, LukeRequestHandlerTest, TestDistribDocBasedVersion, BadComponentTest, QueryEqualityTest, TestMissingGroups, TestJmxMonitoredMap, ZkSolrClientTest, SolrIndexConfigTest, TimeZoneUtilsTest, CSVRequestHandlerTest, DistribDocExpirationUpdateProcessorTest, DistanceFunctionTest, TestReload, DirectUpdateHandlerOptimizeTest, TestNonDefinedSimilarityFactory, SuggesterTSTTest, SharedFSAutoReplicaFailoverUtilsTest, DocValuesTest, DirectSolrConnectionTest, TestDefaultSimilarityFactory, TestReversedWildcardFilterFactory, AliasIntegrationTest, MigrateRouteKeyTest, DocValuesMissingTest, TestSolrDeletionPolicy2, SolrTestCaseJ4Test, SignatureUpdateProcessorFactoryTest, RegexBoostProcessorTest, DistribCursorPagingTest, BadCopyFieldTest, TestIndexSearcher, HdfsCollectionsAPIDistributedZkTest, DeleteLastCustomShardedReplicaTest, DefaultValueUpdateProcessorTest, ConvertedLegacyTest, XmlUpdateRequestHandlerTest, TestSurroundQueryParser, TestJoin, TestLazyCores, TestInitParams, TestManagedSchemaFieldTypeResource, FastVectorHighlighterTest, AddBlockUpdateTest, TestNoOpRegenerator, ChaosMonkeyNothingIsSafeTest, SynonymTokenizerTest, TestStandardQParsers, DirectUpdateHandlerTest, TestSolrQueryParserResource, TestSolrIndexConfig, ShardRoutingCustomTest, ModifyConfFileTest, DistributedDebugComponentTest, TestGroupingSearch, IndexSchemaTest, TestSimpleQParserPlugin, TestStressRecovery, SoftAutoCommitTest, ReplicationFactorTest, TestFastWriter, TestReRankQParserPlugin, TestStressVersions, IndexSchemaRuntimeFieldTest, TermVectorComponentDistributedTest, CoreMergeIndexesAdminHandlerTest, IndexBasedSpellCheckerTest, SchemaVersionSpecificBehaviorTest, TestSchemaManager, CopyFieldTest, FieldMutatingUpdateProcessorTest, TestRecoveryHdfs, JsonLoaderTest, TestSolrXmlPersistence, TestCloudManagedSchemaConcurrent, QueryElevationComponentTest, TestUniqueKeyFieldResource, CoreContainerCoreInitFailuresTest, TestAnalyzeInfixSuggestions, UUIDUpdateProcessorFallbackTest, TestLMDirichletSimilarityFactory, BlockCacheTest, SimpleCollectionCreateDeleteTest, TestSolrQueryParserDefaultOperatorResource, MultiThreadedOCPTest, SpellPossibilityIteratorTest, RemoteQueryErrorTest, TestValueSourceCache, TestSolrXmlPersistor, TestDFRSimilarityFactory, TestSearcherReuse, CursorPagingTest, TestBulkSchemaAPI, TestCopyFieldCollectionResource, BasicDistributedZkTest, BasicDistributedZk2Test, UnloadDistributedZkTest, CollectionsAPIDistributedZkTest]
   [junit4] Completed in 129.94s, 1 test, 1 failure <<< FAILURES!

[...truncated 699 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:525: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:473: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:61: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/extra-targets.xml:39: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build.xml:189: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/common-build.xml:508: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:1359: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:966: There were test failures: 445 suites, 1819 tests, 1 failure, 49 ignored (20 assumptions)

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



[JENKINS] Lucene-Solr-5.x-MacOSX (64bit/jdk1.7.0) - Build # 1911 - Still Failing!

Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-MacOSX/1911/
Java: 64bit/jdk1.7.0 -XX:-UseCompressedOops -XX:+UseG1GC (asserts: true)

All tests passed

Build Log:
[...truncated 61027 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:525: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:432: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/extra-targets.xml:105: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/extra-targets.xml:204: The following files are missing svn:eol-style (or binary svn:mime-type):
* ./solr/server/solr/configsets/data_driven_schema_configs/conf/velocity/VM_global_library.vm
* ./solr/server/solr/configsets/data_driven_schema_configs/conf/velocity/browse.vm
* ./solr/server/solr/configsets/data_driven_schema_configs/conf/velocity/debug.vm
* ./solr/server/solr/configsets/data_driven_schema_configs/conf/velocity/error.vm
* ./solr/server/solr/configsets/data_driven_schema_configs/conf/velocity/facets.vm
* ./solr/server/solr/configsets/data_driven_schema_configs/conf/velocity/footer.vm
* ./solr/server/solr/configsets/data_driven_schema_configs/conf/velocity/head.vm
* ./solr/server/solr/configsets/data_driven_schema_configs/conf/velocity/header.vm
* ./solr/server/solr/configsets/data_driven_schema_configs/conf/velocity/hit.vm
* ./solr/server/solr/configsets/data_driven_schema_configs/conf/velocity/jquery.autocomplete.css
* ./solr/server/solr/configsets/data_driven_schema_configs/conf/velocity/jquery.autocomplete.js
* ./solr/server/solr/configsets/data_driven_schema_configs/conf/velocity/layout.vm
* ./solr/server/solr/configsets/data_driven_schema_configs/conf/velocity/main.css
* ./solr/server/solr/configsets/data_driven_schema_configs/conf/velocity/pagination_bottom.vm
* ./solr/server/solr/configsets/data_driven_schema_configs/conf/velocity/pagination_top.vm
* ./solr/server/solr/configsets/data_driven_schema_configs/conf/velocity/results_list.vm

Total time: 272 minutes 18 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.7.0 -XX:-UseCompressedOops -XX:+UseG1GC (asserts: true)
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any