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/03/01 00:39:36 UTC

[JENKINS] Lucene-Solr-4.x-Linux (64bit/jdk1.8.0-fcs-b129) - Build # 9522 - Failure!

Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/9522/
Java: 64bit/jdk1.8.0-fcs-b129 -XX:+UseCompressedOops -XX:+UseSerialGC

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

Error Message:
Wrong doc count on shard1_0 expected:<300> but was:<301>

Stack Trace:
java.lang.AssertionError: Wrong doc count on shard1_0 expected:<300> but was:<301>
	at __randomizedtesting.SeedInfo.seed([F120B761D800AF5D:70C63979AF5FCF61]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.failNotEquals(Assert.java:647)
	at org.junit.Assert.assertEquals(Assert.java:128)
	at org.junit.Assert.assertEquals(Assert.java:472)
	at org.apache.solr.cloud.ShardSplitTest.checkDocCountsAndShardStates(ShardSplitTest.java:476)
	at org.apache.solr.cloud.ShardSplitTest.splitByUniqueKeyTest(ShardSplitTest.java:248)
	at org.apache.solr.cloud.ShardSplitTest.doTest(ShardSplitTest.java:112)
	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:870)
	at sun.reflect.GeneratedMethodAccessor38.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:483)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
	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.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	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:70)
	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:358)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
	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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	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:358)
	at java.lang.Thread.run(Thread.java:744)




Build Log:
[...truncated 11304 lines...]
   [junit4] Suite: org.apache.solr.cloud.ShardSplitTest
   [junit4]   2> 1177302 T4793 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /hu_brx/wj
   [junit4]   2> 1177304 T4793 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
   [junit4]   2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-ShardSplitTest-1393630601525
   [junit4]   2> 1177304 T4793 oasc.ZkTestServer.run STARTING ZK TEST SERVER
   [junit4]   2> 1177305 T4794 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server
   [junit4]   2> 1177405 T4793 oasc.ZkTestServer.run start zk server on port:33069
   [junit4]   2> 1177406 T4793 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 1177427 T4800 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@3b08e1a2 name:ZooKeeperConnection Watcher:127.0.0.1:33069 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1177427 T4793 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 1177427 T4793 oascc.SolrZkClient.makePath makePath: /solr
   [junit4]   2> 1177431 T4793 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 1177432 T4802 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@24dc8a37 name:ZooKeeperConnection Watcher:127.0.0.1:33069/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1177432 T4793 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 1177432 T4793 oascc.SolrZkClient.makePath makePath: /collections/collection1
   [junit4]   2> 1177434 T4793 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
   [junit4]   2> 1177435 T4793 oascc.SolrZkClient.makePath makePath: /collections/control_collection
   [junit4]   2> 1177436 T4793 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
   [junit4]   2> 1177438 T4793 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml
   [junit4]   2> 1177438 T4793 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 1177441 T4793 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema15.xml to /configs/conf1/schema.xml
   [junit4]   2> 1177441 T4793 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
   [junit4]   2> 1177443 T4793 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1177443 T4793 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1177445 T4793 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
   [junit4]   2> 1177445 T4793 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
   [junit4]   2> 1177447 T4793 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
   [junit4]   2> 1177447 T4793 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
   [junit4]   2> 1177449 T4793 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
   [junit4]   2> 1177449 T4793 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
   [junit4]   2> 1177451 T4793 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml
   [junit4]   2> 1177451 T4793 oascc.SolrZkClient.makePath makePath: /configs/conf1/enumsConfig.xml
   [junit4]   2> 1177452 T4793 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 1177453 T4793 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
   [junit4]   2> 1177456 T4793 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1177456 T4793 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1177458 T4793 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
   [junit4]   2> 1177459 T4793 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
   [junit4]   2> 1177461 T4793 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
   [junit4]   2> 1177461 T4793 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
   [junit4]   2> 1177669 T4793 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 1177682 T4793 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:39168
   [junit4]   2> 1177683 T4793 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 1177683 T4793 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1177683 T4793 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-controljetty-1393630601684
   [junit4]   2> 1177683 T4793 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-controljetty-1393630601684/'
   [junit4]   2> 1177692 T4793 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-controljetty-1393630601684/solr.xml
   [junit4]   2> 1177699 T4793 oasc.CoreContainer.<init> New CoreContainer 343111223
   [junit4]   2> 1177699 T4793 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-controljetty-1393630601684/]
   [junit4]   2> 1177700 T4793 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
   [junit4]   2> 1177700 T4793 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: 
   [junit4]   2> 1177700 T4793 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 1177700 T4793 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 1177700 T4793 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 1177701 T4793 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 1177701 T4793 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 1177701 T4793 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 1177701 T4793 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 1177703 T4793 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1177703 T4793 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1177704 T4793 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 1177704 T4793 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:33069/solr
   [junit4]   2> 1177704 T4793 oasc.ZkController.checkChrootPath zkHost includes chroot
   [junit4]   2> 1177705 T4793 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 1177706 T4813 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@65bb6463 name:ZooKeeperConnection Watcher:127.0.0.1:33069 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1177706 T4793 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 1177708 T4793 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 1177708 T4815 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@3bb010d6 name:ZooKeeperConnection Watcher:127.0.0.1:33069/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1177709 T4793 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 1177710 T4793 oascc.SolrZkClient.makePath makePath: /overseer/queue
   [junit4]   2> 1177711 T4793 oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work
   [junit4]   2> 1177713 T4793 oascc.SolrZkClient.makePath makePath: /live_nodes
   [junit4]   2> 1177714 T4793 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:39168_hu_brx%2Fwj
   [junit4]   2> 1177715 T4793 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:39168_hu_brx%2Fwj
   [junit4]   2> 1177716 T4793 oascc.SolrZkClient.makePath makePath: /overseer_elect
   [junit4]   2> 1177717 T4793 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
   [junit4]   2> 1177719 T4793 oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader 127.0.0.1:39168_hu_brx%2Fwj
   [junit4]   2> 1177719 T4793 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
   [junit4]   2> 1177720 T4793 oasc.Overseer.start Overseer (id=91332975101673475-127.0.0.1:39168_hu_brx%2Fwj-n_0000000000) starting
   [junit4]   2> 1177722 T4793 oascc.SolrZkClient.makePath makePath: /overseer/queue-work
   [junit4]   2> 1177725 T4817 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
   [junit4]   2> 1177726 T4793 oascc.SolrZkClient.makePath makePath: /clusterstate.json
   [junit4]   2> 1177727 T4817 oasc.OverseerCollectionProcessor.prioritizeOverseerNodes prioritizing overseer nodes
   [junit4]   2> 1177729 T4793 oascc.SolrZkClient.makePath makePath: /aliases.json
   [junit4]   2> 1177731 T4793 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 1177734 T4816 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
   [junit4]   2> 1177734 T4818 oasc.ZkController.publish publishing core=collection1 state=down
   [junit4]   2> 1177735 T4818 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
   [junit4]   2> 1177738 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1177738 T4818 oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 1177739 T4816 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
   [junit4]   2> 1177740 T4816 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "state":"down",
   [junit4]   2> 	  "base_url":"http://127.0.0.1:39168/hu_brx/wj",
   [junit4]   2> 	  "core":"collection1",
   [junit4]   2> 	  "roles":null,
   [junit4]   2> 	  "node_name":"127.0.0.1:39168_hu_brx%2Fwj",
   [junit4]   2> 	  "shard":null,
   [junit4]   2> 	  "collection":"control_collection",
   [junit4]   2> 	  "numShards":"1",
   [junit4]   2> 	  "core_node_name":null}
   [junit4]   2> 1177740 T4816 oasc.Overseer$ClusterStateUpdater.createCollection Create collection control_collection with shards [shard1]
   [junit4]   2> 1177740 T4816 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1
   [junit4]   2> 1177742 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1177743 T4815 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> 1178739 T4818 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
   [junit4]   2> 1178739 T4818 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-controljetty-1393630601684/collection1
   [junit4]   2> 1178739 T4818 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection
   [junit4]   2> 1178740 T4818 oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 1178740 T4818 oascc.ZkStateReader.readConfigName Load collection config from:/collections/control_collection
   [junit4]   2> 1178741 T4818 oascc.ZkStateReader.readConfigName path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 1178741 T4818 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-controljetty-1393630601684/collection1/'
   [junit4]   2> 1178742 T4818 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ShardSplitTest-controljetty-1393630601684/collection1/lib/.svn/' to classloader
   [junit4]   2> 1178742 T4818 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ShardSplitTest-controljetty-1393630601684/collection1/lib/classes/' to classloader
   [junit4]   2> 1178743 T4818 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ShardSplitTest-controljetty-1393630601684/collection1/lib/README' to classloader
   [junit4]   2> 1178763 T4818 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_48
   [junit4]   2> 1178774 T4818 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1178775 T4818 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 1178781 T4818 oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 1178888 T4818 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 1178889 T4818 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 1178890 T4818 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1178892 T4818 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1178909 T4818 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1178909 T4818 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-controljetty-1393630601684/collection1/, dataDir=./org.apache.solr.cloud.ShardSplitTest-1393630601525/control/data/
   [junit4]   2> 1178909 T4818 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6c5146e7
   [junit4]   2> 1178910 T4818 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.cloud.ShardSplitTest-1393630601525/control/data
   [junit4]   2> 1178910 T4818 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.ShardSplitTest-1393630601525/control/data/index/
   [junit4]   2> 1178910 T4818 oasc.SolrCore.initIndex WARN [collection1] Solr index directory './org.apache.solr.cloud.ShardSplitTest-1393630601525/control/data/index' doesn't exist. Creating new index...
   [junit4]   2> 1178910 T4818 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.cloud.ShardSplitTest-1393630601525/control/data/index
   [junit4]   2> 1178911 T4818 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=30, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7714639195679752]
   [junit4]   2> 1178911 T4818 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@609c2c8f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6a2ff334),segFN=segments_1,generation=1}
   [junit4]   2> 1178911 T4818 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1178913 T4818 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
   [junit4]   2> 1178913 T4818 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 1178913 T4818 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1178913 T4818 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1178914 T4818 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1178914 T4818 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 1178914 T4818 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1178914 T4818 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1178914 T4818 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1178915 T4818 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 1178915 T4818 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
   [junit4]   2> 1178915 T4818 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 1178915 T4818 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
   [junit4]   2> 1178915 T4818 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 1178915 T4818 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 1178916 T4818 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 1178917 T4818 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1178918 T4818 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 1178919 T4818 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 1178919 T4818 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=2, maxMergeAtOnceExplicit=5, maxMergedSegmentMB=64.5693359375, floorSegmentMB=2.0703125, forceMergeDeletesPctAllowed=23.488933324291185, segmentsPerTier=29.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3328838993699239
   [junit4]   2> 1178919 T4818 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@609c2c8f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6a2ff334),segFN=segments_1,generation=1}
   [junit4]   2> 1178919 T4818 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1178920 T4818 oass.SolrIndexSearcher.<init> Opening Searcher@62600929[collection1] main
   [junit4]   2> 1178921 T4819 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@62600929[collection1] main{StandardDirectoryReader(segments_1:1:nrt)}
   [junit4]   2> 1178921 T4818 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 1178922 T4793 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1
   [junit4]   2> 1178922 T4793 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 1178922 T4822 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:39168/hu_brx/wj collection:control_collection shard:shard1
   [junit4]   2> 1178923 T4793 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 1178923 T4822 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/shard1/election
   [junit4]   2> 1178924 T4824 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@226a3a4 name:ZooKeeperConnection Watcher:127.0.0.1:33069/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1178924 T4793 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 1178925 T4793 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 1178926 T4793 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:false cause connection loss:false
   [junit4]   2> 1178928 T4822 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard1
   [junit4]   2> 1178929 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1178930 T4822 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
   [junit4]   2> 1178930 T4822 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
   [junit4]   2> 1178930 T4816 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
   [junit4]   2> ASYNC  NEW_CORE C1856 name=collection1 org.apache.solr.core.SolrCore@6d37ab83 url=http://127.0.0.1:39168/hu_brx/wj/collection1 node=127.0.0.1:39168_hu_brx%2Fwj C1856_STATE=coll:control_collection core:collection1 props:{state=down, base_url=http://127.0.0.1:39168/hu_brx/wj, core=collection1, node_name=127.0.0.1:39168_hu_brx%2Fwj}
   [junit4]   2> 1178930 T4822 C1856 P39168 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:39168/hu_brx/wj/collection1/
   [junit4]   2> 1178930 T4822 C1856 P39168 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
   [junit4]   2> 1178930 T4822 C1856 P39168 oasc.SyncStrategy.syncToMe http://127.0.0.1:39168/hu_brx/wj/collection1/ has no replicas
   [junit4]   2> 1178931 T4822 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:39168/hu_brx/wj/collection1/ shard1
   [junit4]   2> 1178931 T4822 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/shard1
   [junit4]   2> 1178932 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1178937 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1178939 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1179042 T4815 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> 1179042 T4824 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> 1179093 T4822 oasc.ZkController.register We are http://127.0.0.1:39168/hu_brx/wj/collection1/ and leader is http://127.0.0.1:39168/hu_brx/wj/collection1/
   [junit4]   2> 1179093 T4822 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:39168/hu_brx/wj
   [junit4]   2> 1179094 T4822 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
   [junit4]   2> 1179094 T4822 oasc.ZkController.publish publishing core=collection1 state=active
   [junit4]   2> 1179094 T4822 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
   [junit4]   2> 1179095 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1179095 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1179095 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1179095 T4822 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
   [junit4]   2> 1179096 T4816 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
   [junit4]   2> 1179097 T4816 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "state":"active",
   [junit4]   2> 	  "base_url":"http://127.0.0.1:39168/hu_brx/wj",
   [junit4]   2> 	  "core":"collection1",
   [junit4]   2> 	  "roles":null,
   [junit4]   2> 	  "node_name":"127.0.0.1:39168_hu_brx%2Fwj",
   [junit4]   2> 	  "shard":"shard1",
   [junit4]   2> 	  "collection":"control_collection",
   [junit4]   2> 	  "numShards":"2",
   [junit4]   2> 	  "core_node_name":"core_node1"}
   [junit4]   2> 1179098 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1179147 T4793 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 1
   [junit4]   2> 1179148 T4793 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 1179153 T4793 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:52233
   [junit4]   2> 1179153 T4793 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 1179153 T4793 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1179154 T4793 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-jetty1-1393630603147
   [junit4]   2> 1179154 T4793 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-jetty1-1393630603147/'
   [junit4]   2> 1179163 T4793 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-jetty1-1393630603147/solr.xml
   [junit4]   2> 1179169 T4793 oasc.CoreContainer.<init> New CoreContainer 355569227
   [junit4]   2> 1179170 T4793 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-jetty1-1393630603147/]
   [junit4]   2> 1179170 T4793 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
   [junit4]   2> 1179170 T4793 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: 
   [junit4]   2> 1179171 T4793 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 1179171 T4793 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 1179171 T4793 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 1179171 T4793 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 1179171 T4793 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 1179172 T4793 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 1179172 T4793 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 1179173 T4793 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1179174 T4793 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1179174 T4793 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 1179174 T4793 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:33069/solr
   [junit4]   2> 1179175 T4793 oasc.ZkController.checkChrootPath zkHost includes chroot
   [junit4]   2> 1179175 T4793 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 1179176 T4835 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@301868a8 name:ZooKeeperConnection Watcher:127.0.0.1:33069 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1179176 T4793 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 1179178 T4793 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 1179179 T4837 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@33a13051 name:ZooKeeperConnection Watcher:127.0.0.1:33069/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1179179 T4793 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 1179182 T4793 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 1179200 T4815 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> 1179201 T4837 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> 1179201 T4824 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> 1180184 T4793 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52233_hu_brx%2Fwj
   [junit4]   2> 1180186 T4793 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:52233_hu_brx%2Fwj
   [junit4]   2> 1180190 T4824 oascc.ZkStateReader$3.process Updating live nodes... (2)
   [junit4]   2> 1180190 T4837 oascc.ZkStateReader$3.process Updating live nodes... (2)
   [junit4]   2> 1180190 T4815 oascc.ZkStateReader$3.process Updating live nodes... (2)
   [junit4]   2> 1180196 T4838 oasc.ZkController.publish publishing core=collection1 state=down
   [junit4]   2> 1180196 T4838 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
   [junit4]   2> 1180197 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1180198 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1180198 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1180197 T4838 oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 1180200 T4816 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
   [junit4]   2> 1180201 T4816 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "state":"down",
   [junit4]   2> 	  "base_url":"http://127.0.0.1:52233/hu_brx/wj",
   [junit4]   2> 	  "core":"collection1",
   [junit4]   2> 	  "roles":null,
   [junit4]   2> 	  "node_name":"127.0.0.1:52233_hu_brx%2Fwj",
   [junit4]   2> 	  "shard":null,
   [junit4]   2> 	  "collection":"collection1",
   [junit4]   2> 	  "numShards":"2",
   [junit4]   2> 	  "core_node_name":null}
   [junit4]   2> 1180201 T4816 oasc.Overseer$ClusterStateUpdater.createCollection Create collection collection1 with shards [shard1, shard2]
   [junit4]   2> 1180201 T4816 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard2
   [junit4]   2> 1180204 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1180309 T4824 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
   [junit4]   2> 1180309 T4815 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
   [junit4]   2> 1180309 T4837 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
   [junit4]   2> 1181198 T4838 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
   [junit4]   2> 1181199 T4838 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-jetty1-1393630603147/collection1
   [junit4]   2> 1181199 T4838 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
   [junit4]   2> 1181199 T4838 oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 1181200 T4838 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1
   [junit4]   2> 1181200 T4838 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 1181200 T4838 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-jetty1-1393630603147/collection1/'
   [junit4]   2> 1181201 T4838 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ShardSplitTest-jetty1-1393630603147/collection1/lib/.svn/' to classloader
   [junit4]   2> 1181201 T4838 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ShardSplitTest-jetty1-1393630603147/collection1/lib/classes/' to classloader
   [junit4]   2> 1181201 T4838 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ShardSplitTest-jetty1-1393630603147/collection1/lib/README' to classloader
   [junit4]   2> 1181227 T4838 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_48
   [junit4]   2> 1181235 T4838 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1181236 T4838 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 1181240 T4838 oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 1181335 T4838 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 1181336 T4838 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 1181337 T4838 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1181339 T4838 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1181351 T4838 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1181352 T4838 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-jetty1-1393630603147/collection1/, dataDir=./org.apache.solr.cloud.ShardSplitTest-1393630601525/jetty1/
   [junit4]   2> 1181352 T4838 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6c5146e7
   [junit4]   2> 1181352 T4838 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.cloud.ShardSplitTest-1393630601525/jetty1
   [junit4]   2> 1181352 T4838 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.ShardSplitTest-1393630601525/jetty1/index/
   [junit4]   2> 1181353 T4838 oasc.SolrCore.initIndex WARN [collection1] Solr index directory './org.apache.solr.cloud.ShardSplitTest-1393630601525/jetty1/index' doesn't exist. Creating new index...
   [junit4]   2> 1181353 T4838 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.cloud.ShardSplitTest-1393630601525/jetty1/index
   [junit4]   2> 1181353 T4838 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=30, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7714639195679752]
   [junit4]   2> 1181353 T4838 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@170e2603 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3815744a),segFN=segments_1,generation=1}
   [junit4]   2> 1181354 T4838 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1181355 T4838 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
   [junit4]   2> 1181356 T4838 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 1181356 T4838 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1181356 T4838 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1181356 T4838 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1181356 T4838 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 1181356 T4838 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1181357 T4838 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1181357 T4838 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1181357 T4838 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 1181357 T4838 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
   [junit4]   2> 1181357 T4838 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 1181358 T4838 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
   [junit4]   2> 1181358 T4838 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 1181358 T4838 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 1181358 T4838 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 1181360 T4838 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1181361 T4838 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 1181361 T4838 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 1181361 T4838 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=2, maxMergeAtOnceExplicit=5, maxMergedSegmentMB=64.5693359375, floorSegmentMB=2.0703125, forceMergeDeletesPctAllowed=23.488933324291185, segmentsPerTier=29.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3328838993699239
   [junit4]   2> 1181362 T4838 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@170e2603 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3815744a),segFN=segments_1,generation=1}
   [junit4]   2> 1181362 T4838 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1181362 T4838 oass.SolrIndexSearcher.<init> Opening Searcher@38cf548c[collection1] main
   [junit4]   2> 1181364 T4839 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@38cf548c[collection1] main{StandardDirectoryReader(segments_1:1:nrt)}
   [junit4]   2> 1181364 T4838 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 1181365 T4793 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1
   [junit4]   2> 1181365 T4793 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 1181365 T4842 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:52233/hu_brx/wj collection:collection1 shard:shard2
   [junit4]   2> 1181366 T4842 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard2/election
   [junit4]   2> 1181370 T4842 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard2
   [junit4]   2> 1181371 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1181371 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1181371 T4842 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
   [junit4]   2> 1181371 T4842 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
   [junit4]   2> 1181371 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> ASYNC  NEW_CORE C1857 name=collection1 org.apache.solr.core.SolrCore@40c9e6bc url=http://127.0.0.1:52233/hu_brx/wj/collection1 node=127.0.0.1:52233_hu_brx%2Fwj C1857_STATE=coll:collection1 core:collection1 props:{state=down, base_url=http://127.0.0.1:52233/hu_brx/wj, core=collection1, node_name=127.0.0.1:52233_hu_brx%2Fwj}
   [junit4]   2> 1181371 T4842 C1857 P52233 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:52233/hu_brx/wj/collection1/
   [junit4]   2> 1181371 T4842 C1857 P52233 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
   [junit4]   2> 1181372 T4842 C1857 P52233 oasc.SyncStrategy.syncToMe http://127.0.0.1:52233/hu_brx/wj/collection1/ has no replicas
   [junit4]   2> 1181372 T4842 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:52233/hu_brx/wj/collection1/ shard2
   [junit4]   2> 1181372 T4842 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard2
   [junit4]   2> 1181372 T4816 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
   [junit4]   2> 1181375 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1181379 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1181381 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1181482 T4815 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
   [junit4]   2> 1181482 T4837 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
   [junit4]   2> 1181482 T4824 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
   [junit4]   2> 1181529 T4842 oasc.ZkController.register We are http://127.0.0.1:52233/hu_brx/wj/collection1/ and leader is http://127.0.0.1:52233/hu_brx/wj/collection1/
   [junit4]   2> 1181529 T4842 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:52233/hu_brx/wj
   [junit4]   2> 1181530 T4842 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
   [junit4]   2> 1181530 T4842 oasc.ZkController.publish publishing core=collection1 state=active
   [junit4]   2> 1181530 T4842 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
   [junit4]   2> 1181532 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1181533 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1181533 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1181534 T4816 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
   [junit4]   2> 1181534 T4816 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "state":"active",
   [junit4]   2> 	  "base_url":"http://127.0.0.1:52233/hu_brx/wj",
   [junit4]   2> 	  "core":"collection1",
   [junit4]   2> 	  "roles":null,
   [junit4]   2> 	  "node_name":"127.0.0.1:52233_hu_brx%2Fwj",
   [junit4]   2> 	  "shard":"shard2",
   [junit4]   2> 	  "collection":"collection1",
   [junit4]   2> 	  "numShards":"2",
   [junit4]   2> 	  "core_node_name":"core_node1"}
   [junit4]   2> 1181535 T4842 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
   [junit4]   2> 1181537 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1181603 T4793 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 2
   [junit4]   2> 1181603 T4793 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 1181605 T4793 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:32803
   [junit4]   2> 1181606 T4793 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 1181606 T4793 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1181606 T4793 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-jetty2-1393630605587
   [junit4]   2> 1181607 T4793 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-jetty2-1393630605587/'
   [junit4]   2> 1181616 T4793 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-jetty2-1393630605587/solr.xml
   [junit4]   2> 1181622 T4793 oasc.CoreContainer.<init> New CoreContainer 1599311085
   [junit4]   2> 1181622 T4793 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-jetty2-1393630605587/]
   [junit4]   2> 1181623 T4793 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
   [junit4]   2> 1181623 T4793 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: 
   [junit4]   2> 1181623 T4793 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 1181623 T4793 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 1181623 T4793 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 1181624 T4793 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 1181624 T4793 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 1181624 T4793 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 1181624 T4793 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 1181626 T4793 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1181626 T4793 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1181626 T4793 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 1181627 T4793 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:33069/solr
   [junit4]   2> 1181627 T4793 oasc.ZkController.checkChrootPath zkHost includes chroot
   [junit4]   2> 1181628 T4793 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 1181629 T4853 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@3b48c857 name:ZooKeeperConnection Watcher:127.0.0.1:33069 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1181629 T4793 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 1181631 T4793 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 1181635 T4855 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@8f9ffc name:ZooKeeperConnection Watcher:127.0.0.1:33069/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1181636 T4793 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 1181639 T4815 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
   [junit4]   2> 1181639 T4824 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
   [junit4]   2> 1181639 T4837 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
   [junit4]   2> 1181641 T4793 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 1182643 T4793 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:32803_hu_brx%2Fwj
   [junit4]   2> 1182645 T4793 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:32803_hu_brx%2Fwj
   [junit4]   2> 1182649 T4824 oascc.ZkStateReader$3.process Updating live nodes... (3)
   [junit4]   2> 1182649 T4837 oascc.ZkStateReader$3.process Updating live nodes... (3)
   [junit4]   2> 1182649 T4855 oascc.ZkStateReader$3.process Updating live nodes... (3)
   [junit4]   2> 1182649 T4815 oascc.ZkStateReader$3.process Updating live nodes... (3)
   [junit4]   2> 1182655 T4856 oasc.ZkController.publish publishing core=collection1 state=down
   [junit4]   2> 1182656 T4856 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
   [junit4]   2> 1182657 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1182657 T4856 oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 1182657 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1182658 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1182659 T4816 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
   [junit4]   2> 1182660 T4816 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "state":"down",
   [junit4]   2> 	  "base_url":"http://127.0.0.1:32803/hu_brx/wj",
   [junit4]   2> 	  "core":"collection1",
   [junit4]   2> 	  "roles":null,
   [junit4]   2> 	  "node_name":"127.0.0.1:32803_hu_brx%2Fwj",
   [junit4]   2> 	  "shard":null,
   [junit4]   2> 	  "collection":"collection1",
   [junit4]   2> 	  "numShards":"2",
   [junit4]   2> 	  "core_node_name":null}
   [junit4]   2> 1182660 T4816 oasc.Overseer$ClusterStateUpdater.updateState Collection already exists with numShards=2
   [junit4]   2> 1182660 T4816 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1
   [junit4]   2> 1182663 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1182767 T4824 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
   [junit4]   2> 1182767 T4837 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
   [junit4]   2> 1182767 T4855 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
   [junit4]   2> 1182767 T4815 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
   [junit4]   2> 1183657 T4856 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
   [junit4]   2> 1183658 T4856 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-jetty2-1393630605587/collection1
   [junit4]   2> 1183658 T4856 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
   [junit4]   2> 1183658 T4856 oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 1183659 T4856 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1
   [junit4]   2> 1183660 T4856 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 1183660 T4856 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-jetty2-1393630605587/collection1/'
   [junit4]   2> 1183660 T4856 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ShardSplitTest-jetty2-1393630605587/collection1/lib/.svn/' to classloader
   [junit4]   2> 1183661 T4856 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ShardSplitTest-jetty2-1393630605587/collection1/lib/classes/' to classloader
   [junit4]   2> 1183661 T4856 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ShardSplitTest-jetty2-1393630605587/collection1/lib/README' to classloader
   [junit4]   2> 1183677 T4856 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_48
   [junit4]   2> 1183684 T4856 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1183685 T4856 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 1183689 T4856 oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 1183794 T4856 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 1183795 T4856 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 1183796 T4856 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1183798 T4856 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1183812 T4856 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1183812 T4856 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-jetty2-1393630605587/collection1/, dataDir=./org.apache.solr.cloud.ShardSplitTest-1393630601525/jetty2/
   [junit4]   2> 1183812 T4856 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6c5146e7
   [junit4]   2> 1183813 T4856 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.cloud.ShardSplitTest-1393630601525/jetty2
   [junit4]   2> 1183813 T4856 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.ShardSplitTest-1393630601525/jetty2/index/
   [junit4]   2> 1183813 T4856 oasc.SolrCore.initIndex WARN [collection1] Solr index directory './org.apache.solr.cloud.ShardSplitTest-1393630601525/jetty2/index' doesn't exist. Creating new index...
   [junit4]   2> 1183813 T4856 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.cloud.ShardSplitTest-1393630601525/jetty2/index
   [junit4]   2> 1183813 T4856 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=30, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7714639195679752]
   [junit4]   2> 1183814 T4856 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@60df07f3 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5b685596),segFN=segments_1,generation=1}
   [junit4]   2> 1183814 T4856 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1183816 T4856 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
   [junit4]   2> 1183816 T4856 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 1183816 T4856 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1183816 T4856 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1183816 T4856 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1183817 T4856 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 1183817 T4856 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1183817 T4856 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1183817 T4856 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1183818 T4856 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 1183818 T4856 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
   [junit4]   2> 1183818 T4856 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 1183818 T4856 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
   [junit4]   2> 1183818 T4856 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 1183819 T4856 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 1183819 T4856 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 1183820 T4856 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1183821 T4856 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 1183821 T4856 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 1183822 T4856 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=2, maxMergeAtOnceExplicit=5, maxMergedSegmentMB=64.5693359375, floorSegmentMB=2.0703125, forceMergeDeletesPctAllowed=23.488933324291185, segmentsPerTier=29.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3328838993699239
   [junit4]   2> 1183822 T4856 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@60df07f3 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5b685596),segFN=segments_1,generation=1}
   [junit4]   2> 1183822 T4856 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1183823 T4856 oass.SolrIndexSearcher.<init> Opening Searcher@45208786[collection1] main
   [junit4]   2> 1183825 T4857 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@45208786[collection1] main{StandardDirectoryReader(segments_1:1:nrt)}
   [junit4]   2> 1183826 T4856 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 1183827 T4793 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1
   [junit4]   2> 1183827 T4793 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 1183827 T4860 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:32803/hu_brx/wj collection:collection1 shard:shard1
   [junit4]   2> 1183828 T4860 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election
   [junit4]   2> 1183832 T4860 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard1
   [junit4]   2> 1183833 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1183833 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1183833 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1183833 T4860 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
   [junit4]   2> 1183833 T4860 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
   [junit4]   2> ASYNC  NEW_CORE C1858 name=collection1 org.apache.solr.core.SolrCore@9f5db1f url=http://127.0.0.1:32803/hu_brx/wj/collection1 node=127.0.0.1:32803_hu_brx%2Fwj C1858_STATE=coll:collection1 core:collection1 props:{state=down, base_url=http://127.0.0.1:32803/hu_brx/wj, core=collection1, node_name=127.0.0.1:32803_hu_brx%2Fwj}
   [junit4]   2> 1183834 T4860 C1858 P32803 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:32803/hu_brx/wj/collection1/
   [junit4]   2> 1183834 T4860 C1858 P32803 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
   [junit4]   2> 1183834 T4816 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
   [junit4]   2> 1183834 T4860 C1858 P32803 oasc.SyncStrategy.syncToMe http://127.0.0.1:32803/hu_brx/wj/collection1/ has no replicas
   [junit4]   2> 1183834 T4860 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:32803/hu_brx/wj/collection1/ shard1
   [junit4]   2> 1183834 T4860 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
   [junit4]   2> 1183837 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1183839 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1183841 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1183947 T4824 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
   [junit4]   2> 1183948 T4855 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
   [junit4]   2> 1183948 T4815 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
   [junit4]   2> 1183947 T4837 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
   [junit4]   2> 1183989 T4860 oasc.ZkController.register We are http://127.0.0.1:32803/hu_brx/wj/collection1/ and leader is http://127.0.0.1:32803/hu_brx/wj/collection1/
   [junit4]   2> 1183990 T4860 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:32803/hu_brx/wj
   [junit4]   2> 1183990 T4860 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
   [junit4]   2> 1183990 T4860 oasc.ZkController.publish publishing core=collection1 state=active
   [junit4]   2> 1183990 T4860 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
   [junit4]   2> 1183991 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1183992 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1183992 T4860 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
   [junit4]   2> 1183992 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1183993 T4816 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
   [junit4]   2> 1183993 T4816 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "state":"active",
   [junit4]   2> 	  "base_url":"http://127.0.0.1:32803/hu_brx/wj",
   [junit4]   2> 	  "core":"collection1",
   [junit4]   2> 	  "roles":null,
   [junit4]   2> 	  "node_name":"127.0.0.1:32803_hu_brx%2Fwj",
   [junit4]   2> 	  "shard":"shard1",
   [junit4]   2> 	  "collection":"collection1",
   [junit4]   2> 	  "numShards":"2",
   [junit4]   2> 	  "core_node_name":"core_node2"}
   [junit4]   2> 1183995 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1184046 T4793 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 3
   [junit4]   2> 1184046 T4793 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 1184049 T4793 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:59168
   [junit4]   2> 1184049 T4793 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 1184050 T4793 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1184050 T4793 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.cloud.ShardSplitTest-jetty3-1393630608048
   [junit4]   2> 1184050 T4793 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.cloud.ShardSplitTest-jetty3-1393630608048/'
   [junit4]   2> 1184058 T4793 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-jetty3-1393630608048/solr.xml
   [junit4]   2> 1184064 T4793 oasc.CoreContainer.<init> New CoreContainer 2042274472
   [junit4]   2> 1184065 T4793 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.cloud.ShardSplitTest-jetty3-1393630608048/]
   [junit4]   2> 1184065 T4793 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
   [junit4]   2> 1184065 T4793 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: 
   [junit4]   2> 1184065 T4793 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 1184066 T4793 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 1184066 T4793 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 1184066 T4793 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 1184066 T4793 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 1184067 T4793 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 1184067 T4793 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 1184068 T4793 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1184068 T4793 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1184069 T4793 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 1184069 T4793 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:33069/solr
   [junit4]   2> 1184069 T4793 oasc.ZkController.checkChrootPath zkHost includes chroot
   [junit4]   2> 1184070 T4793 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 1184071 T4871 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@256421d9 name:ZooKeeperConnection Watcher:127.0.0.1:33069 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1184071 T4793 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 1184073 T4793 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 1184074 T4873 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1076bd75 name:ZooKeeperConnection Watcher:127.0.0.1:33069/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1184074 T4793 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 1184078 T4793 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 1184097 T4824 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
   [junit4]   2> 1184098 T4855 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
   [junit4]   2> 1184098 T4815 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
   [junit4]   2> 1184097 T4837 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
   [junit4]   2> 1184098 T4873 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
   [junit4]   2> 1185082 T4793 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59168_hu_brx%2Fwj
   [junit4]   2> 1185083 T4793 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:59168_hu_brx%2Fwj
   [junit4]   2> 1185085 T4815 oascc.ZkStateReader$3.process Updating live nodes... (4)
   [junit4]   2> 1185085 T4855 oascc.ZkStateReader$3.process Updating live nodes... (4)
   [junit4]   2> 1185085 T4824 oascc.ZkStateReader$3.process Updating live nodes... (4)
   [junit4]   2> 1185085 T4837 oascc.ZkStateReader$3.process Updating live nodes... (4)
   [junit4]   2> 1185085 T4873 oascc.ZkStateReader$3.process Updating live nodes... (4)
   [junit4]   2> 1185089 T4874 oasc.ZkController.publish publishing core=collection1 state=down
   [junit4]   2> 1185089 T4874 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
   [junit4]   2> 1185090 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1185090 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1185090 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1185090 T4874 oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 1185091 T4816 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
   [junit4]   2> 1185091 T4816 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "state":"down",
   [junit4]   2> 	  "base_url":"http://127.0.0.1:59168/hu_brx/wj",
   [junit4]   2> 	  "core":"collection1",
   [junit4]   2> 	  "roles":null,
   [junit4]   2> 	  "node_name":"127.0.0.1:59168_hu_brx%2Fwj",
   [junit4]   2> 	  "shard":null,
   [junit4]   2> 	  "collection":"collection1",
   [junit4]   2> 	  "numShards":"2",
   [junit4]   2> 	  "core_node_name":null}
   [junit4]   2> 1185092 T4816 oasc.Overseer$ClusterStateUpdater.updateState Collection already exists with numShards=2
   [junit4]   2> 1185092 T4816 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard2
   [junit4]   2> 1185093 T4815 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
   [junit4]   2> 1185195 T4824 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
   [junit4]   2> 1185196 T4873 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
   [junit4]   2> 1185196 T4855 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
   [junit4]   2> 1185195 T4815 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
   [junit4]   2> 1185195 T4837 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
   [junit4]   2> 1186091 T4874 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
   [junit4]   2> 1186091 T4874 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.cloud.ShardSplitTest-jetty3-1393630608048/collection1
   [junit4]   2> 1186091 T4874 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
   [junit4]   2> 1186092 T4874 oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 1186092 T4874 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1
   [junit4]   2> 1186093 T4874 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 1186093 T4874 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.cloud.ShardSplitTest-jetty3-1393630608048/collection1/'
   [junit4]   2> 1186093 T4874 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ShardSplitTest-jetty3-1393630608048/collection1/lib/.svn/' to classloader
   [junit4]   2> 1186094 T4874 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ShardSplitTest-jetty3-1393630608048/collection1/lib/classes/' to classloader
   [junit4]   2> 1186094 T4874 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.ShardSplitTest-jetty3-1393630608048/collection1/lib/README' to classloader
   [junit4]   2> 1186134 T4874 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_48
   [junit4]   2> 1186143 T4874 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1186144 T4874 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 1186148 T4874 oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 1186250 T4874 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 1186251 T4874 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 1186252 T4874 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1186254 T4874 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1186269 T4874 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1186269 T4874 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.cloud.ShardSplitTest-jetty3-1393630608048/collection1/, dataDir=./org.apache.solr.cloud.ShardSplitTest-1393630601525/jetty3/
   [junit4]   2> 1186269 T4874 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6c5146e7
   [junit4]   2> 1186270 T4874 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.cloud.ShardSplitTest-1393630601525/jetty3
   [junit4]   2> 1186270 T4874 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.ShardSplitTest-1393630601525/jetty3/index/
   [junit4]   2> 1186270 T4874 oasc.SolrCore.initIndex WARN [collection1] Solr index directory './org.apache.solr.cloud.ShardSplitTest-1393630601525/jetty3/index' doesn't exist. Creating new index...
   [junit4]   2> 1186270 T4874 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.cloud.ShardSplitTest-1393630601525/jetty3/index
   [junit4]   2> 1186271 T4874 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=3

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

(LeaderElector.java:55)
   [junit4]   2> 	at org.apache.solr.cloud.LeaderElector$1.process(LeaderElector.java:137)
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:519)
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:495)
   [junit4]   2> 
   [junit4]   2> 1347625 T4931 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@54e15396 name:ZooKeeperConnection Watcher:127.0.0.1:33069/solr got event WatchedEvent state:Disconnected type:None path:null path:null type:None
   [junit4]   2> 1347625 T4793 oasc.ChaosMonkey.monkeyLog monkey: stop shard! 39168
   [junit4]   2> 1347625 T4931 oascc.ConnectionManager.process Client->ZooKeeper status change trigger but we are already closed
   [junit4]   2> !!!! WARNING: best effort to remove /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ShardSplitTest-1393630601525 FAILED !!!!!
   [junit4]   2> 1347626 T4793 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
   [junit4]   2> 1347626 T4793 oasc.ZkTestServer.send4LetterWord connecting to 127.0.0.1:33069 33069
   [junit4]   1>             "shard1_0":{
   [junit4]   1>               "parent":"shard1",
   [junit4]   1>               "range":"80000000-dfffffff",
   [junit4]   1>               "state":"construction",
   [junit4]   1>               "replicas":{
   [junit4]   1>                 "core_node5":{
   [junit4]   1>                   "state":"active",
   [junit4]   1>                   "base_url":"http://127.0.0.1:32803/hu_brx/wj",
   [junit4]   1>                   "core":"collection1_shard1_0_replica1",
   [junit4]   1>                   "node_name":"127.0.0.1:32803_hu_brx%2Fwj",
   [junit4]   1>                   "leader":"true"},
   [junit4]   1>                 "core_node7":{
   [junit4]   1>                   "state":"recovering",
   [junit4]   1>                   "base_url":"http://127.0.0.1:39168/hu_brx/wj",
   [junit4]   1>                   "core":"collection1_shard1_0_replica2",
   [junit4]   1>                   "node_name":"127.0.0.1:39168_hu_brx%2Fwj"}}},
   [junit4]   1>             "shard1_1":{
   [junit4]   1>               "parent":"shard1",
   [junit4]   1>               "range":"e0000000-ffffffff",
   [junit4]   1>               "state":"construction",
   [junit4]   1>               "replicas":{
   [junit4]   1>                 "core_node6":{
   [junit4]   1>                   "state":"active",
   [junit4]   1>                   "base_url":"http://127.0.0.1:32803/hu_brx/wj",
   [junit4]   1>                   "core":"collection1_shard1_1_replica1",
   [junit4]   1>                   "node_name":"127.0.0.1:32803_hu_brx%2Fwj",
   [junit4]   1>                   "leader":"true"},
   [junit4]   1>                 "core_node8":{
   [junit4]   1>                   "state":"recovering",
   [junit4]   1>                   "base_url":"http://127.0.0.1:52233/hu_brx/wj",
   [junit4]   1>                   "core":"collection1_shard1_1_replica2",
   [junit4]   1>                   "node_name":"127.0.0.1:52233_hu_brx%2Fwj"}}}},
   [junit4]   1>           "router":{"name":"compositeId"},
   [junit4]   1>           "autoCreated":"true",
   [junit4]   1>           "maxShardsPerNode":"1"}}
   [junit4]   1> 
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=ShardSplitTest -Dtests.method=testDistribSearch -Dtests.seed=F120B761D800AF5D -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=no_NO_NY -Dtests.timezone=Australia/North -Dtests.file.encoding=US-ASCII
   [junit4] FAILURE  170s J1 | ShardSplitTest.testDistribSearch <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: Wrong doc count on shard1_0 expected:<300> but was:<301>
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([F120B761D800AF5D:70C63979AF5FCF61]:0)
   [junit4]    > 	at org.apache.solr.cloud.ShardSplitTest.checkDocCountsAndShardStates(ShardSplitTest.java:476)
   [junit4]    > 	at org.apache.solr.cloud.ShardSplitTest.splitByUniqueKeyTest(ShardSplitTest.java:248)
   [junit4]    > 	at org.apache.solr.cloud.ShardSplitTest.doTest(ShardSplitTest.java:112)
   [junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:870)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:744)
   [junit4]   2> 1347640 T4793 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 170344 T4792 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will linger awaiting termination of 1 leaked thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting, sim=DefaultSimilarity, locale=no_NO_NY, timezone=Australia/North
   [junit4]   2> NOTE: Linux 3.8.0-36-generic amd64/Oracle Corporation 1.8.0 (64-bit)/cpus=8,threads=1,free=95292864,total=296349696
   [junit4]   2> NOTE: All tests run in this JVM: [AlternateDirectoryTest, TestRangeQuery, TestFastOutputStream, TestDistribDocBasedVersion, StatsComponentTest, TestSimpleQParserPlugin, TestAnalyzedSuggestions, TestFastWriter, TestInitQParser, ChangedSchemaMergeTest, StandardRequestHandlerTest, TimeZoneUtilsTest, TestDistributedSearch, NoCacheHeaderTest, SuggesterWFSTTest, MigrateRouteKeyTest, TestNonNRTOpen, TestCloudManagedSchemaAddField, DefaultValueUpdateProcessorTest, CurrencyFieldOpenExchangeTest, TestFastLRUCache, DisMaxRequestHandlerTest, ConvertedLegacyTest, ShardRoutingCustomTest, ChaosMonkeySafeLeaderTest, MinimalSchemaTest, TestRecovery, TriLevelCompositeIdRoutingTest, TestXIncludeConfig, TestFieldTypeResource, TestDynamicFieldResource, BadCopyFieldTest, PathHierarchyTokenizerFactoryTest, TestDynamicFieldCollectionResource, TestNumberUtils, TestQuerySenderNoQuery, HdfsBasicDistributedZk2Test, HighlighterTest, TestZkChroot, FileUtilsTest, DistanceFunctionTest, DocumentAnalysisRequestHandlerTest, TestAnalyzeInfixSuggestions, PluginInfoTest, TestCollationFieldDocValues, DistributedQueryComponentOptimizationTest, ZkSolrClientTest, SpellingQueryConverterTest, NumericFieldsTest, TestSolrCoreProperties, SolrRequestParserTest, BasicDistributedZk2Test, TestReload, TestPhraseSuggestions, DirectSolrConnectionTest, InfoHandlerTest, TestPartialUpdateDeduplication, SortByFunctionTest, CustomCollectionTest, TestDefaultSimilarityFactory, HdfsChaosMonkeySafeLeaderTest, DirectSolrSpellCheckerTest, BasicZkTest, SolrCmdDistributorTest, TestRTGBase, SimplePostToolTest, CurrencyFieldXmlFileTest, ZkNodePropsTest, RequestHandlersTest, SpellCheckComponentTest, SpellCheckCollatorTest, HighlighterConfigTest, SolrPluginUtilsTest, HardAutoCommitTest, TestArbitraryIndexDir, TestBinaryResponseWriter, HdfsUnloadDistributedZkTest, CursorMarkTest, CursorPagingTest, DocValuesMultiTest, TestClassNameShortening, PreAnalyzedFieldTest, TestCursorMarkWithoutUniqueKey, FullSolrCloudDistribCmdsTest, TestIBSimilarityFactory, TestStressReorder, TestCoreDiscovery, TestCloudManagedSchema, SyncSliceTest, LeaderElectionIntegrationTest, TestRandomFaceting, SliceStateUpdateTest, TestDistributedGrouping, DistributedSpellCheckComponentTest, TestRealTimeGet, SimpleFacetsTest, TestSolr4Spatial, PeerSyncTest, TestSort, TestFunctionQuery, TestLazyCores, DirectUpdateHandlerTest, TestIndexSearcher, SoftAutoCommitTest, AnalysisAfterCoreReloadTest, TestExtendedDismaxParser, TestFoldingMultitermQuery, TestStressLucene, SpatialFilterTest, SchemaVersionSpecificBehaviorTest, TestUpdate, TestAtomicUpdateErrorCases, QueryEqualityTest, XsltUpdateRequestHandlerTest, CacheHeaderTest, TestSurroundQueryParser, LukeRequestHandlerTest, FileBasedSpellCheckerTest, XmlUpdateRequestHandlerTest, TestValueSourceCache, RequiredFieldsTest, TestSolrQueryParser, IndexSchemaRuntimeFieldTest, TestJmxIntegration, JSONWriterTest, QueryParsingTest, BinaryUpdateRequestHandlerTest, TestPHPSerializedResponseWriter, CSVRequestHandlerTest, CoreContainerCoreInitFailuresTest, TestLFUCache, TestSolrIndexConfig, BadComponentTest, TestSolrDeletionPolicy2, MultiTermTest, TestBinaryField, TestSearchPerf, OutputWriterTest, TestFuzzyAnalyzedSuggestions, TestPostingsSolrHighlighter, NotRequiredUniqueKeyTest, TestCharFilters, TestCodecSupport, TestSweetSpotSimilarityFactory, TestDFRSimilarityFactory, TestPerFieldSimilarity, TestLMDirichletSimilarityFactory, TestLMJelinekMercerSimilarityFactory, TestBM25SimilarityFactory, LegacyHTMLStripCharFilterTest, TestJmxMonitoredMap, ScriptEngineTest, OpenExchangeRatesOrgProviderTest, URLClassifyProcessorTest, ChaosMonkeyNothingIsSafeTest, ConnectionManagerTest, DeleteReplicaTest, DistribCursorPagingTest, ShardSplitTest]
   [junit4] Completed on J1 in 170.62s, 1 test, 1 failure <<< FAILURES!

[...truncated 10 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:471: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:451: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/extra-targets.xml:37: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:189: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/common-build.xml:490: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1278: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:911: There were test failures: 363 suites, 1570 tests, 1 failure, 37 ignored (9 assumptions)

Total time: 53 minutes 13 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.8.0-fcs-b129 -XX:+UseCompressedOops -XX:+UseSerialGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure



[JENKINS] Lucene-Solr-4.x-Linux (64bit/jdk1.8.0-fcs-b129) - Build # 9524 - Still Failing!

Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/9524/
Java: 64bit/jdk1.8.0-fcs-b129 -XX:+UseCompressedOops -XX:+UseSerialGC

1 tests failed.
REGRESSION:  org.apache.solr.client.solrj.impl.CloudSolrServerTest.testDistribSearch

Error Message:
java.util.concurrent.TimeoutException: Could not connect to ZooKeeper 127.0.0.1:33437 within 30000 ms

Stack Trace:
org.apache.solr.common.SolrException: java.util.concurrent.TimeoutException: Could not connect to ZooKeeper 127.0.0.1:33437 within 30000 ms
	at __randomizedtesting.SeedInfo.seed([1EE6598618232AA9:9F00D79E6F7C4A95]:0)
	at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:148)
	at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:99)
	at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:94)
	at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:85)
	at org.apache.solr.cloud.AbstractZkTestCase.buildZooKeeper(AbstractZkTestCase.java:89)
	at org.apache.solr.cloud.AbstractZkTestCase.buildZooKeeper(AbstractZkTestCase.java:83)
	at org.apache.solr.cloud.AbstractDistribZkTestBase.setUp(AbstractDistribZkTestBase.java:70)
	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.setUp(AbstractFullDistribZkTestBase.java:200)
	at org.apache.solr.client.solrj.impl.CloudSolrServerTest.setUp(CloudSolrServerTest.java:78)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:483)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:771)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
	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.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	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:70)
	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:358)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
	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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	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:358)
	at java.lang.Thread.run(Thread.java:744)
Caused by: java.util.concurrent.TimeoutException: Could not connect to ZooKeeper 127.0.0.1:33437 within 30000 ms
	at org.apache.solr.common.cloud.ConnectionManager.waitForConnected(ConnectionManager.java:222)
	at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:140)
	... 47 more




Build Log:
[...truncated 11538 lines...]
   [junit4] Suite: org.apache.solr.client.solrj.impl.CloudSolrServerTest
   [junit4]   2> 17265 T110 oas.SolrTestCaseJ4.startTrackingSearchers WARN startTrackingSearchers: numOpens=13 numCloses=13
   [junit4]   2> 17265 T110 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (true)
   [junit4]   2> 17266 T110 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /_k/a
   [junit4]   2> 17267 T110 oasc.AbstractZkTestCase.<clinit> WARN TEST_HOME() does not exist - solrj test?
   [junit4]   2> 17270 T110 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
   [junit4]   2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J0/./solrtest-CloudSolrServerTest-1393644778020
   [junit4]   2> 17273 T110 oasc.ZkTestServer.run STARTING ZK TEST SERVER
   [junit4]   2> 17275 T111 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server
   [junit4]   2> 17432 T110 oasc.ZkTestServer.run start zk server on port:33437
   [junit4]   2> 17476 T110 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 17486 T112 oazs.NIOServerCnxn.doIO WARN Exception causing close of session 0x0 due to java.io.IOException: ZooKeeperServer not running
   [junit4]   2> 52849 T114 oazsp.FileTxnLog.commit WARN fsync-ing the write ahead log in SyncThread:0 took 34239ms which will adversely effect operation latency. See the ZooKeeper troubleshooting guide
   [junit4]   2> 52852 T110 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
   [junit4]   2> 52868 T112 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x1447bb3b2e40000, likely client has closed socket
   [junit4]   2> 	at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:220)
   [junit4]   2> 	at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:744)
   [junit4]   2> 
   [junit4]   2> 52870 T110 oasc.ZkTestServer.send4LetterWord connecting to 127.0.0.1:33437 33437
   [junit4]   1> client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=CloudSolrServerTest -Dtests.method=testDistribSearch -Dtests.seed=1EE6598618232AA9 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=vi_VN -Dtests.timezone=Atlantic/South_Georgia -Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   35.7s J0 | CloudSolrServerTest.testDistribSearch <<<
   [junit4]    > Throwable #1: org.apache.solr.common.SolrException: java.util.concurrent.TimeoutException: Could not connect to ZooKeeper 127.0.0.1:33437 within 30000 ms
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([1EE6598618232AA9:9F00D79E6F7C4A95]:0)
   [junit4]    > 	at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:148)
   [junit4]    > 	at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:99)
   [junit4]    > 	at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:94)
   [junit4]    > 	at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:85)
   [junit4]    > 	at org.apache.solr.cloud.AbstractZkTestCase.buildZooKeeper(AbstractZkTestCase.java:89)
   [junit4]    > 	at org.apache.solr.cloud.AbstractZkTestCase.buildZooKeeper(AbstractZkTestCase.java:83)
   [junit4]    > 	at org.apache.solr.cloud.AbstractDistribZkTestBase.setUp(AbstractDistribZkTestBase.java:70)
   [junit4]    > 	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.setUp(AbstractFullDistribZkTestBase.java:200)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.CloudSolrServerTest.setUp(CloudSolrServerTest.java:78)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:744)
   [junit4]    > Caused by: java.util.concurrent.TimeoutException: Could not connect to ZooKeeper 127.0.0.1:33437 within 30000 ms
   [junit4]    > 	at org.apache.solr.common.cloud.ConnectionManager.waitForConnected(ConnectionManager.java:222)
   [junit4]    > 	at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:140)
   [junit4]    > 	... 47 more
   [junit4]   2> 52992 T110 oas.SolrTestCaseJ4.setUp ###Starting testShutdown
   [junit4]   2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J0/./solrtest-CloudSolrServerTest-1393644813741
   [junit4]   2> 52993 T110 oasc.ZkTestServer.run STARTING ZK TEST SERVER
   [junit4]   2> 52993 T118 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server
   [junit4]   2> 53093 T110 oasc.ZkTestServer.run start zk server on port:45397
   [junit4]   2> 53094 T110 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 53146 T124 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6cc0ab13 name:ZooKeeperConnection Watcher:127.0.0.1:45397 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 53147 T110 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 53148 T110 oascc.SolrZkClient.makePath makePath: /solr
   [junit4]   2> 53175 T110 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 53179 T126 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@746ab122 name:ZooKeeperConnection Watcher:127.0.0.1:45397/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 53179 T110 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 53183 T110 oascc.SolrZkClient.makePath makePath: /collections/collection1
   [junit4]   2> 53188 T110 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
   [junit4]   2> 53193 T110 oascc.SolrZkClient.makePath makePath: /collections/control_collection
   [junit4]   2> 53196 T110 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
   [junit4]   2> 53200 T110 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
   [junit4]   2> 53201 T110 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 53207 T110 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
   [junit4]   2> 53208 T110 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
   [junit4]   2> 53213 T110 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml because it doesn't exist
   [junit4]   2> 53214 T110 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/stopwords.txt because it doesn't exist
   [junit4]   2> 53214 T110 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/protwords.txt because it doesn't exist
   [junit4]   2> 53214 T110 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/currency.xml because it doesn't exist
   [junit4]   2> 53214 T110 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/enumsConfig.xml because it doesn't exist
   [junit4]   2> 53215 T110 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/open-exchange-rates.json because it doesn't exist
   [junit4]   2> 53215 T110 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/mapping-ISOLatin1Accent.txt because it doesn't exist
   [junit4]   2> 53215 T110 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/old_synonyms.txt because it doesn't exist
   [junit4]   2> 53215 T110 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/synonyms.txt because it doesn't exist
   [junit4]   2> 53223 T110 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 53224 T128 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6690816 name:ZooKeeperConnection Watcher:127.0.0.1:45397/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 53225 T110 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 53235 T110 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 53260 T129 oaz.ClientCnxnSocketNIO.connect ERROR Unable to open socket to ff01:0:0:0:0:0:0:114/ff01:0:0:0:0:0:0:114:33332
   [junit4]   2> 53260 T129 oaz.ClientCnxn$SendThread.run WARN Session 0x0 for server null, unexpected error, closing socket connection and attempting reconnect java.net.SocketException: Network is unreachable
   [junit4]   2> 	at sun.nio.ch.Net.connect0(Native Method)
   [junit4]   2> 	at sun.nio.ch.Net.connect(Net.java:435)
   [junit4]   2> 	at sun.nio.ch.Net.connect(Net.java:427)
   [junit4]   2> 	at sun.nio.ch.SocketChannelImpl.connect(SocketChannelImpl.java:643)
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.registerAndConnect(ClientCnxnSocketNIO.java:266)
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.connect(ClientCnxnSocketNIO.java:276)
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:958)
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:993)
   [junit4]   2> 
   [junit4]   2> 54362 T129 oaz.ClientCnxnSocketNIO.connect ERROR Unable to open socket to ff01:0:0:0:0:0:0:114/ff01:0:0:0:0:0:0:114:33332
   [junit4]   2> 54464 T110 oas.SolrTestCaseJ4.tearDown ###Ending testShutdown
   [junit4]   2> 54466 T110 oasc.ZkTestServer.send4LetterWord connecting to 127.0.0.1:45397 45397
   [junit4]   1> client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 54517 T110 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 37256 T109 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will linger awaiting termination of 1 leaked thread(s).
   [junit4]   2> NOTE: test params are: codec=Lucene3x, sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=vi_VN, timezone=Atlantic/South_Georgia
   [junit4]   2> NOTE: Linux 3.8.0-36-generic amd64/Oracle Corporation 1.8.0 (64-bit)/cpus=8,threads=1,free=145272312,total=189792256
   [junit4]   2> NOTE: All tests run in this JVM: [LargeVolumeEmbeddedTest, TestJavaBinCodec, SolrExampleXMLTest, ContentStreamTest, LargeVolumeBinaryJettyTest, TestEmbeddedSolrServer, TestCoreAdmin, SolrParamTest, DocumentAnalysisResponseTest, CloudSolrServerTest]
   [junit4] Completed on J0 in 38.04s, 2 tests, 1 error <<< FAILURES!

[...truncated 118 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:471: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:451: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/extra-targets.xml:37: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:202: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/common-build.xml:490: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1278: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:911: There were test failures: 48 suites, 280 tests, 1 error

Total time: 46 minutes 13 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.8.0-fcs-b129 -XX:+UseCompressedOops -XX:+UseSerialGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure



[JENKINS] Lucene-Solr-4.x-Linux (64bit/jdk1.7.0_51) - Build # 9523 - Still Failing!

Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/9523/
Java: 64bit/jdk1.7.0_51 -XX:+UseCompressedOops -XX:+UseG1GC -XX:-UseSuperWord

1 tests failed.
FAILED:  org.apache.solr.client.solrj.impl.CloudSolrServerTest.testShutdown

Error Message:
java.util.concurrent.TimeoutException: Could not connect to ZooKeeper 127.0.0.1:45697 within 30000 ms

Stack Trace:
org.apache.solr.common.SolrException: java.util.concurrent.TimeoutException: Could not connect to ZooKeeper 127.0.0.1:45697 within 30000 ms
	at __randomizedtesting.SeedInfo.seed([84DD5B3869675E3A:67AB52AD8E1DCB48]:0)
	at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:148)
	at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:99)
	at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:94)
	at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:85)
	at org.apache.solr.cloud.AbstractZkTestCase.buildZooKeeper(AbstractZkTestCase.java:89)
	at org.apache.solr.cloud.AbstractZkTestCase.buildZooKeeper(AbstractZkTestCase.java:83)
	at org.apache.solr.cloud.AbstractDistribZkTestBase.setUp(AbstractDistribZkTestBase.java:70)
	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.setUp(AbstractFullDistribZkTestBase.java:200)
	at org.apache.solr.client.solrj.impl.CloudSolrServerTest.setUp(CloudSolrServerTest.java:78)
	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:1559)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:771)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
	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.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	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:70)
	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:358)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
	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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	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:358)
	at java.lang.Thread.run(Thread.java:744)
Caused by: java.util.concurrent.TimeoutException: Could not connect to ZooKeeper 127.0.0.1:45697 within 30000 ms
	at org.apache.solr.common.cloud.ConnectionManager.waitForConnected(ConnectionManager.java:222)
	at org.apache.solr.common.cloud.SolrZkClient.<init>(SolrZkClient.java:140)
	... 47 more




Build Log:
[...truncated 122 lines...]
ERROR: Failed to update http://svn.apache.org/repos/asf/lucene/dev/branches/branch_4x
org.tmatesoft.svn.core.SVNException: svn: E175002: OPTIONS /repos/asf/lucene/dev/branches/branch_4x failed
	at org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection.request(HTTPConnection.java:388)
	at org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection.request(HTTPConnection.java:373)
	at org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection.request(HTTPConnection.java:361)
	at org.tmatesoft.svn.core.internal.io.dav.DAVConnection.performHttpRequest(DAVConnection.java:707)
	at org.tmatesoft.svn.core.internal.io.dav.DAVConnection.exchangeCapabilities(DAVConnection.java:627)
	at org.tmatesoft.svn.core.internal.io.dav.DAVConnection.open(DAVConnection.java:102)
	at org.tmatesoft.svn.core.internal.io.dav.DAVRepository.openConnection(DAVRepository.java:1020)
	at org.tmatesoft.svn.core.internal.io.dav.DAVRepository.getRepositoryUUID(DAVRepository.java:148)
	at org.tmatesoft.svn.core.internal.wc16.SVNBasicDelegate.createRepository(SVNBasicDelegate.java:339)
	at org.tmatesoft.svn.core.internal.wc16.SVNBasicDelegate.createRepository(SVNBasicDelegate.java:328)
	at org.tmatesoft.svn.core.internal.wc16.SVNUpdateClient16.update(SVNUpdateClient16.java:482)
	at org.tmatesoft.svn.core.internal.wc16.SVNUpdateClient16.doUpdate(SVNUpdateClient16.java:364)
	at org.tmatesoft.svn.core.internal.wc16.SVNUpdateClient16.doUpdate(SVNUpdateClient16.java:274)
	at org.tmatesoft.svn.core.internal.wc2.old.SvnOldUpdate.run(SvnOldUpdate.java:27)
	at org.tmatesoft.svn.core.internal.wc2.old.SvnOldUpdate.run(SvnOldUpdate.java:11)
	at org.tmatesoft.svn.core.internal.wc2.SvnOperationRunner.run(SvnOperationRunner.java:20)
	at org.tmatesoft.svn.core.wc2.SvnOperationFactory.run(SvnOperationFactory.java:1238)
	at org.tmatesoft.svn.core.wc2.SvnOperation.run(SvnOperation.java:294)
	at org.tmatesoft.svn.core.wc.SVNUpdateClient.doUpdate(SVNUpdateClient.java:311)
	at org.tmatesoft.svn.core.wc.SVNUpdateClient.doUpdate(SVNUpdateClient.java:291)
	at org.tmatesoft.svn.core.wc.SVNUpdateClient.doUpdate(SVNUpdateClient.java:387)
	at hudson.scm.subversion.UpdateUpdater$TaskImpl.perform(UpdateUpdater.java:157)
	at hudson.scm.subversion.WorkspaceUpdater$UpdateTask.delegateTo(WorkspaceUpdater.java:161)
	at hudson.scm.SubversionSCM$CheckOutTask.perform(SubversionSCM.java:1029)
	at hudson.scm.SubversionSCM$CheckOutTask.invoke(SubversionSCM.java:1010)
	at hudson.scm.SubversionSCM$CheckOutTask.invoke(SubversionSCM.java:986)
	at hudson.FilePath.act(FilePath.java:914)
	at hudson.FilePath.act(FilePath.java:887)
	at hudson.scm.SubversionSCM.checkout(SubversionSCM.java:935)
	at hudson.scm.SubversionSCM.checkout(SubversionSCM.java:870)
	at hudson.model.AbstractProject.checkout(AbstractProject.java:1411)
	at hudson.model.AbstractBuild$AbstractBuildExecution.defaultCheckout(AbstractBuild.java:671)
	at jenkins.scm.SCMCheckoutStrategy.checkout(SCMCheckoutStrategy.java:88)
	at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:580)
	at hudson.model.Run.execute(Run.java:1670)
	at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:46)
	at hudson.model.ResourceController.execute(ResourceController.java:88)
	at hudson.model.Executor.run(Executor.java:231)
Caused by: svn: E175002: OPTIONS /repos/asf/lucene/dev/branches/branch_4x failed
	at org.tmatesoft.svn.core.SVNErrorMessage.create(SVNErrorMessage.java:208)
	at org.tmatesoft.svn.core.SVNErrorMessage.create(SVNErrorMessage.java:154)
	at org.tmatesoft.svn.core.SVNErrorMessage.create(SVNErrorMessage.java:97)
	... 38 more
Caused by: org.tmatesoft.svn.core.SVNException: svn: E175002: OPTIONS request failed on '/repos/asf/lucene/dev/branches/branch_4x'
svn: E175002: unknown host
	at org.tmatesoft.svn.core.internal.wc.SVNErrorManager.error(SVNErrorManager.java:64)
	at org.tmatesoft.svn.core.internal.wc.SVNErrorManager.error(SVNErrorManager.java:51)
	at org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection._request(HTTPConnection.java:777)
	at org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection.request(HTTPConnection.java:382)
	... 37 more
Caused by: svn: E175002: OPTIONS request failed on '/repos/asf/lucene/dev/branches/branch_4x'
	at org.tmatesoft.svn.core.SVNErrorMessage.create(SVNErrorMessage.java:208)
	at org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection._request(HTTPConnection.java:775)
	... 38 more
Caused by: svn: E175002: unknown host
	at org.tmatesoft.svn.core.SVNErrorMessage.create(SVNErrorMessage.java:208)
	at org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection._request(HTTPConnection.java:517)
	... 38 more
Caused by: java.net.UnknownHostException: svn.apache.org: Name or service not known
	at java.net.Inet6AddressImpl.lookupAllHostAddr(Native Method)
	at java.net.InetAddress$1.lookupAllHostAddr(InetAddress.java:901)
	at java.net.InetAddress.getAddressesFromNameService(InetAddress.java:1293)
	at java.net.InetAddress.getAllByName0(InetAddress.java:1246)
	at java.net.InetAddress.getAllByName(InetAddress.java:1162)
	at java.net.InetAddress.getAllByName(InetAddress.java:1098)
	at java.net.InetAddress.getByName(InetAddress.java:1048)
	at org.tmatesoft.svn.core.internal.util.SVNSocketFactory.createAddres(SVNSocketFactory.java:189)
	at org.tmatesoft.svn.core.internal.util.SVNSocketFactory.createPlainSocket(SVNSocketFactory.java:66)
	at org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection.connect(HTTPConnection.java:280)
	at org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection._request(HTTPConnection.java:451)
	... 38 more
ERROR: Subversion update failed
java.io.IOException
	at hudson.scm.subversion.UpdateUpdater$TaskImpl.perform(UpdateUpdater.java:207)
	at hudson.scm.subversion.WorkspaceUpdater$UpdateTask.delegateTo(WorkspaceUpdater.java:161)
	at hudson.scm.SubversionSCM$CheckOutTask.perform(SubversionSCM.java:1029)
	at hudson.scm.SubversionSCM$CheckOutTask.invoke(SubversionSCM.java:1010)
	at hudson.scm.SubversionSCM$CheckOutTask.invoke(SubversionSCM.java:986)
	at hudson.FilePath.act(FilePath.java:914)
	at hudson.FilePath.act(FilePath.java:887)
	at hudson.scm.SubversionSCM.checkout(SubversionSCM.java:935)
	at hudson.scm.SubversionSCM.checkout(SubversionSCM.java:870)
	at hudson.model.AbstractProject.checkout(AbstractProject.java:1411)
	at hudson.model.AbstractBuild$AbstractBuildExecution.defaultCheckout(AbstractBuild.java:671)
	at jenkins.scm.SCMCheckoutStrategy.checkout(SCMCheckoutStrategy.java:88)
	at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:580)
	at hudson.model.Run.execute(Run.java:1670)
	at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:46)
	at hudson.model.ResourceController.execute(ResourceController.java:88)
	at hudson.model.Executor.run(Executor.java:231)
Caused by: hudson.scm.subversion.UpdaterException: failed to perform svn update
	... 17 more
Caused by: org.tmatesoft.svn.core.SVNException: svn: E175002: OPTIONS /repos/asf/lucene/dev/branches/branch_4x failed
	at org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection.request(HTTPConnection.java:388)
	at org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection.request(HTTPConnection.java:373)
	at org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection.request(HTTPConnection.java:361)
	at org.tmatesoft.svn.core.internal.io.dav.DAVConnection.performHttpRequest(DAVConnection.java:707)
	at org.tmatesoft.svn.core.internal.io.dav.DAVConnection.exchangeCapabilities(DAVConnection.java:627)
	at org.tmatesoft.svn.core.internal.io.dav.DAVConnection.open(DAVConnection.java:102)
	at org.tmatesoft.svn.core.internal.io.dav.DAVRepository.openConnection(DAVRepository.java:1020)
	at org.tmatesoft.svn.core.internal.io.dav.DAVRepository.getRepositoryUUID(DAVRepository.java:148)
	at org.tmatesoft.svn.core.internal.wc16.SVNBasicDelegate.createRepository(SVNBasicDelegate.java:339)
	at org.tmatesoft.svn.core.internal.wc16.SVNBasicDelegate.createRepository(SVNBasicDelegate.java:328)
	at org.tmatesoft.svn.core.internal.wc16.SVNUpdateClient16.update(SVNUpdateClient16.java:482)
	at org.tmatesoft.svn.core.internal.wc16.SVNUpdateClient16.doUpdate(SVNUpdateClient16.java:364)
	at org.tmatesoft.svn.core.internal.wc16.SVNUpdateClient16.doUpdate(SVNUpdateClient16.java:274)
	at org.tmatesoft.svn.core.internal.wc2.old.SvnOldUpdate.run(SvnOldUpdate.java:27)
	at org.tmatesoft.svn.core.internal.wc2.old.SvnOldUpdate.run(SvnOldUpdate.java:11)
	at org.tmatesoft.svn.core.internal.wc2.SvnOperationRunner.run(SvnOperationRunner.java:20)
	at org.tmatesoft.svn.core.wc2.SvnOperationFactory.run(SvnOperationFactory.java:1238)
	at org.tmatesoft.svn.core.wc2.SvnOperation.run(SvnOperation.java:294)
	at org.tmatesoft.svn.core.wc.SVNUpdateClient.doUpdate(SVNUpdateClient.java:311)
	at org.tmatesoft.svn.core.wc.SVNUpdateClient.doUpdate(SVNUpdateClient.java:291)
	at org.tmatesoft.svn.core.wc.SVNUpdateClient.doUpdate(SVNUpdateClient.java:387)
	at hudson.scm.subversion.UpdateUpdater$TaskImpl.perform(UpdateUpdater.java:157)
	... 16 more
Caused by: svn: E175002: OPTIONS /repos/asf/lucene/dev/branches/branch_4x failed
	at org.tmatesoft.svn.core.SVNErrorMessage.create(SVNErrorMessage.java:208)
	at org.tmatesoft.svn.core.SVNErrorMessage.create(SVNErrorMessage.java:154)
	at org.tmatesoft.svn.core.SVNErrorMessage.create(SVNErrorMessage.java:97)
	... 38 more
Caused by: org.tmatesoft.svn.core.SVNException: svn: E175002: OPTIONS request failed on '/repos/asf/lucene/dev/branches/branch_4x'
svn: E175002: unknown host
	at org.tmatesoft.svn.core.internal.wc.SVNErrorManager.error(SVNErrorManager.java:64)
	at org.tmatesoft.svn.core.internal.wc.SVNErrorManager.error(SVNErrorManager.java:51)
	at org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection._request(HTTPConnection.java:777)
	at org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection.request(HTTPConnection.java:382)
	... 37 more
Caused by: svn: E175002: OPTIONS request failed on '/repos/asf/lucene/dev/branches/branch_4x'
	at org.tmatesoft.svn.core.SVNErrorMessage.create(SVNErrorMessage.java:208)
	at org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection._request(HTTPConnection.java:775)
	... 38 more
Caused by: svn: E175002: unknown host
	at org.tmatesoft.svn.core.SVNErrorMessage.create(SVNErrorMessage.java:208)
	at org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection._request(HTTPConnection.java:517)
	... 38 more
Caused by: java.net.UnknownHostException: svn.apache.org: Name or service not known
	at java.net.Inet6AddressImpl.lookupAllHostAddr(Native Method)
	at java.net.InetAddress$1.lookupAllHostAddr(InetAddress.java:901)
	at java.net.InetAddress.getAddressesFromNameService(InetAddress.java:1293)
	at java.net.InetAddress.getAllByName0(InetAddress.java:1246)
	at java.net.InetAddress.getAllByName(InetAddress.java:1162)
	at java.net.InetAddress.getAllByName(InetAddress.java:1098)
	at java.net.InetAddress.getByName(InetAddress.java:1048)
	at org.tmatesoft.svn.core.internal.util.SVNSocketFactory.createAddres(SVNSocketFactory.java:189)
	at org.tmatesoft.svn.core.internal.util.SVNSocketFactory.createPlainSocket(SVNSocketFactory.java:66)
	at org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection.connect(HTTPConnection.java:280)
	at org.tmatesoft.svn.core.internal.io.dav.http.HTTPConnection._request(HTTPConnection.java:451)
	... 38 more
Retrying after 10 seconds
Cleaning up /var/lib/jenkins/workspace/Lucene-Solr-4.x-Linux/.
Updating http://svn.apache.org/repos/asf/lucene/dev/branches/branch_4x at revision '2014-03-01T01:01:35.493 +0000'
At revision 1573118
no change for http://svn.apache.org/repos/asf/lucene/dev/branches/branch_4x since the previous build
No emails were triggered.
[Lucene-Solr-4.x-Linux] $ /bin/sh -xe /tmp/hudson7189631583051661152.sh
+ echo Using JDK: 64bit/jdk1.7.0_51 -XX:+UseCompressedOops -XX:+UseG1GC -XX:-UseSuperWord
Using JDK: 64bit/jdk1.7.0_51 -XX:+UseCompressedOops -XX:+UseG1GC -XX:-UseSuperWord
+ /var/lib/jenkins/tools/java/64bit/jdk1.7.0_51/bin/java -XX:+UseCompressedOops -XX:+UseG1GC -XX:-UseSuperWord -version
java version "1.7.0_51"
Java(TM) SE Runtime Environment (build 1.7.0_51-b13)
Java HotSpot(TM) 64-Bit Server VM (build 24.51-b03, mixed mode)
[Lucene-Solr-4.x-Linux] $ /var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/bin/ant "-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC -XX:-UseSuperWord" -Dtests.disableHdfs=true -Dtests.multiplier=3 -Dtests.jvms=2 jenkins-hourly
Buildfile: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml

jenkins-hourly:

clean:

clean:
     [echo] Building solr...

clean:

-test-with-heapdumps-enabled:
     [echo] Java HotSpot(TM) 64-Bit Server VM: Enabling heap dumps on OutOfMemoryError to dir '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/heapdumps'.
    [mkdir] Created dir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/heapdumps

test:

-run-test:
    [mkdir] Created dir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build

ivy-availability-check:

ivy-fail:

ivy-configure:
[ivy:configure] :: Apache Ivy 2.3.0 - 20130110142753 :: http://ant.apache.org/ivy/ ::
[ivy:configure] :: loading settings :: file = /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/ivy-settings.xml

-clover.load:

resolve-groovy:
[ivy:cachepath] :: resolving dependencies :: org.codehaus.groovy#groovy-all-caller;working
[ivy:cachepath] 	confs: [default]
[ivy:cachepath] 	found org.codehaus.groovy#groovy-all;2.2.1 in public
[ivy:cachepath] :: resolution report :: resolve 170ms :: artifacts dl 3ms
	---------------------------------------------------------------------
	|                  |            modules            ||   artifacts   |
	|       conf       | number| search|dwnlded|evicted|| number|dwnlded|
	---------------------------------------------------------------------
	|      default     |   1   |   0   |   0   |   0   ||   1   |   0   |
	---------------------------------------------------------------------

-init-totals:

test-core:

-clover.disable:

ivy-availability-check:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/ivy-settings.xml

-clover.load:

-clover.classpath:

-clover.setup:

clover:

resolve:

init:

compile-core:
    [mkdir] Created dir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/core/classes/java
    [javac] Compiling 710 source files to /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/core/classes/java
    [javac] /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/core/src/java/org/apache/lucene/util/PriorityQueue.java:65: warning: [unchecked] unchecked cast
    [javac]     heap = (T[]) new Object[heapSize]; // T is unbounded type, so this unchecked cast works always
    [javac]                  ^
    [javac]   required: T[]
    [javac]   found:    Object[]
    [javac]   where T is a type-variable:
    [javac]     T extends Object declared in class PriorityQueue
    [javac] Note: Some input files use or override a deprecated API.
    [javac] Note: Recompile with -Xlint:deprecation for details.
    [javac] 1 warning
     [copy] Copying 3 files to /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/core/classes/java

compile-test-framework:

ivy-availability-check:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/ivy-settings.xml

resolve:

init:

compile-lucene-core:

ivy-availability-check:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/ivy-settings.xml

resolve:

init:

-clover.disable:

-clover.load:

-clover.classpath:

-clover.setup:

clover:

compile-core:

compile-codecs:
     [echo] Building codecs...

ivy-availability-check:
     [echo] Building codecs...

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/ivy-settings.xml

resolve:

common.init:

compile-lucene-core:

init:

-clover.disable:

-clover.load:

-clover.classpath:

-clover.setup:

clover:

compile-core:
    [mkdir] Created dir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/codecs/classes/java
    [javac] Compiling 74 source files to /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/codecs/classes/java
    [javac] Note: Some input files use or override a deprecated API.
    [javac] Note: Recompile with -Xlint:deprecation for details.
     [copy] Copying 3 files to /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/codecs/classes/java

-clover.disable:

-clover.load:

-clover.classpath:

-clover.setup:

clover:

common.compile-core:
    [mkdir] Created dir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/test-framework/classes/java
    [javac] Compiling 145 source files to /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/test-framework/classes/java
    [javac] Note: Some input files use or override a deprecated API.
    [javac] Note: Recompile with -Xlint:deprecation for details.
     [copy] Copying 4 files to /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/test-framework/classes/java

compile-core:

compile-test:
    [mkdir] Created dir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/core/classes/test
    [javac] Compiling 401 source files to /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/core/classes/test
    [javac] Note: Some input files use or override a deprecated API.
    [javac] Note: Recompile with -Xlint:deprecation for details.
     [copy] Copying 42 files to /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/core/classes/test

install-junit4-taskdef:

validate:

resolve-groovy:

-init-totals:

-test:
    [mkdir] Created dir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/core/test
    [mkdir] Created dir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/core/test/temp
    [mkdir] Created dir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/.caches/test-stats/core
   [junit4] <JUnit4> says salut! Master seed: 443FE98E844B5D4D
   [junit4] Executing 385 suites with 2 JVMs.
   [junit4] 
   [junit4] Started J0 PID(12284@serv1.sd-datasolutions.de).
   [junit4] Started J1 PID(12282@serv1.sd-datasolutions.de).
   [junit4] Suite: org.apache.lucene.search.TestDocIdSet
   [junit4] Completed on J0 in 1.09s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestFilterIterator
   [junit4] Completed on J0 in 0.12s, 8 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.automaton.TestDeterminizeLexicon
   [junit4] Completed on J0 in 4.61s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestFieldCacheRewriteMethod
   [junit4] Completed on J0 in 5.15s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTieredMergePolicy
   [junit4] Completed on J1 in 12.47s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestLockFactory
   [junit4] IGNOR/A 0.11s J0 | TestLockFactory.testStressLocks
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly)
   [junit4] IGNOR/A 0.01s J0 | TestLockFactory.testStressLocksNativeFSLockFactory
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly)
   [junit4] Completed on J0 in 1.52s, 11 tests, 2 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestIndexableBinaryStringTools
   [junit4] Completed on J0 in 1.07s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestRollback
   [junit4] Completed on J0 in 0.05s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestRateLimiter
   [junit4] Completed on J1 in 1.30s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDocumentsWriterDeleteQueue
   [junit4] Completed on J0 in 0.66s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.document.TestDateTools
   [junit4] Completed on J0 in 0.08s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestShardSearching
   [junit4] Completed on J0 in 15.95s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestSpanMultiTermQueryWrapper
   [junit4] Completed on J0 in 0.46s, 8 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestScorerPerf
   [junit4] Completed on J0 in 24.95s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestTimeLimitingCollector
   [junit4] Completed on J0 in 5.42s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestSegmentReader
   [junit4] Completed on J0 in 1.29s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestRegexpQuery
   [junit4] Completed on J0 in 0.25s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestFilteredQuery
   [junit4] Completed on J0 in 0.93s, 12 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexableField
   [junit4] Completed on J0 in 1.91s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestExplanations
   [junit4] Completed on J0 in 0.09s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.perfield.TestPerFieldDocValuesFormat
   [junit4] IGNOR/A 0.07s J1 | TestPerFieldDocValuesFormat.testHugeBinaryValueLimit
   [junit4]    > Assumption #1: test requires codec with limits on max binary field length
   [junit4] Completed on J1 in 54.08s, 79 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDirectoryReader
   [junit4] Completed on J0 in 2.37s, 27 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestMathUtil
   [junit4] Completed on J0 in 0.06s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestBagOfPostings
   [junit4] Completed on J1 in 3.95s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.packed.TestEliasFanoSequence
   [junit4] Completed on J0 in 4.15s, 24 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestBooleanQuery
   [junit4] Completed on J1 in 0.60s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestByteArrayDataInput
   [junit4] Completed on J1 in 0.03s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestDisjunctionMaxQuery
   [junit4] Completed on J0 in 1.03s, 11 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTransactions
   [junit4] Completed on J1 in 2.17s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexInput
   [junit4] Completed on J1 in 1.17s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.automaton.TestLevenshteinAutomata
   [junit4] Completed on J1 in 2.53s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene41.TestBlockPostingsFormat
   [junit4] Completed on J1 in 2.65s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.TestWorstCaseTestBehavior
   [junit4] Completed on J1 in 0.03s, 6 tests, 6 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestRollingBuffer
   [junit4] Completed on J1 in 0.53s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestNoMergePolicy
   [junit4] Completed on J1 in 0.05s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestSameTokenSamePosition
   [junit4] Completed on J1 in 0.12s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestNamedSPILoader
   [junit4] Completed on J1 in 0.03s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestLiveFieldValues
   [junit4] Completed on J1 in 4.18s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.analysis.TestToken
   [junit4] Completed on J1 in 1.03s, 10 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestLazyProxSkipping
   [junit4] Completed on J1 in 0.71s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDocsAndPositions
   [junit4] Completed on J1 in 2.12s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestTimSorter
   [junit4] Completed on J1 in 0.57s, 9 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestMultiTermConstantScore
   [junit4] Completed on J1 in 1.03s, 8 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSearchWithThreads
   [junit4] Completed on J1 in 5.74s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestCachingWrapperFilter
   [junit4] Completed on J1 in 0.64s, 11 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene40.TestLucene40StoredFieldsFormat
   [junit4] IGNOR/A 0.01s J1 | TestLucene40StoredFieldsFormat.testBigDocuments
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly)
   [junit4] Completed on J1 in 4.50s, 10 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestBroadWord
   [junit4] Completed on J1 in 0.50s, 11 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene42.TestLucene42DocValuesFormat
   [junit4] IGNOR/A 0.01s J0 | TestLucene42DocValuesFormat.testThreeNumbersOneMissingWithMerging
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J0 | TestLucene42DocValuesFormat.testTwoNumbersOneMissing
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J0 | TestLucene42DocValuesFormat.testThreads2
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J0 | TestLucene42DocValuesFormat.testTwoBytesOneMissingWithMerging
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J0 | TestLucene42DocValuesFormat.testThreeBytesOneMissingWithMerging
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J0 | TestLucene42DocValuesFormat.testLongMissingVsFieldCache
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J0 | TestLucene42DocValuesFormat.testTwoNumbersOneMissingWithMerging
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J0 | TestLucene42DocValuesFormat.testShortMissingVsFieldCache
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J0 | TestLucene42DocValuesFormat.testTwoBytesOneMissing
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J0 | TestLucene42DocValuesFormat.testByteMissingVsFieldCache
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J0 | TestLucene42DocValuesFormat.testIntMissingVsFieldCache
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] Completed on J0 in 35.74s, 81 tests, 11 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestCustomSearcherSort
   [junit4] Completed on J0 in 2.23s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.automaton.TestUTF32ToUTF8
   [junit4] Completed on J0 in 4.11s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestNoDeletionPolicy
   [junit4] Completed on J0 in 0.17s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene45.TestLucene45DocValuesFormat
   [junit4] IGNOR/A 0.01s J1 | TestLucene45DocValuesFormat.testHugeBinaryValueLimit
   [junit4]    > Assumption #1: test requires codec with limits on max binary field length
   [junit4] Completed on J1 in 23.06s, 81 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestSpans
   [junit4] Completed on J1 in 0.61s, 26 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestFixedBitSet
   [junit4] Completed on J0 in 13.13s, 11 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.automaton.TestMinimize
   [junit4] Completed on J1 in 2.29s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestFieldValueFilter
   [junit4] Completed on J1 in 0.05s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestAutomatonQueryUnicode
   [junit4] Completed on J0 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestFieldCacheRangeFilter
   [junit4] Completed on J0 in 0.83s, 9 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSubScorerFreqs
   [junit4] Completed on J0 in 0.14s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDuelingCodecs
   [junit4] Completed on J1 in 11.53s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestParallelCompositeReader
   [junit4] Completed on J1 in 0.82s, 13 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestPerSegmentDeletes
   [junit4] Completed on J1 in 0.06s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.analysis.TestCachingTokenFilter
   [junit4] Completed on J1 in 0.03s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestRamUsageEstimatorOnWildAnimals
   [junit4] Completed on J1 in 0.65s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestTermVectors
   [junit4] Completed on J1 in 0.21s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestCollectionUtil
   [junit4] Completed on J1 in 9.68s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestSloppyMath
   [junit4] Completed on J1 in 0.14s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.document.TestDocument
   [junit4] Completed on J1 in 0.20s, 11 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestMatchAllDocsQuery
   [junit4] Completed on J1 in 0.04s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestAttributeSource
   [junit4] Completed on J1 in 0.04s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestRecyclingIntBlockAllocator
   [junit4] Completed on J1 in 0.08s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestIOUtils
   [junit4] Completed on J1 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestLongPostings
   [junit4] Completed on J1 in 3.13s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestAddIndexes
   [junit4] Completed on J1 in 3.32s, 23 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterMergePolicy
   [junit4] Completed on J1 in 3.47s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestBinaryTerms
   [junit4] Completed on J1 in 0.13s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.payloads.TestPayloadExplanations
   [junit4] Completed on J1 in 0.64s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.compressing.TestCompressingTermVectorsFormat
   [junit4] Completed on J0 in 41.19s, 40 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.compressing.TestFastCompressionMode
   [junit4] Completed on J0 in 1.15s, 11 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.payloads.TestPayloadTermQuery
   [junit4] Completed on J0 in 0.46s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.compressing.TestFastDecompressionMode
   [junit4] Completed on J0 in 2.41s, 11 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestSegmentTermDocs
   [junit4] Completed on J0 in 0.73s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSameScoresWithThreads
   [junit4] Completed on J0 in 2.01s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestPostingsOffsets
   [junit4] Completed on J0 in 2.30s, 11 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestPriorityQueue
   [junit4] Completed on J0 in 0.06s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestQueryBuilder
   [junit4] Completed on J0 in 0.10s, 19 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestCrashCausesCorruptIndex
   [junit4] Completed on J0 in 0.26s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.compressing.TestCompressingStoredFieldsFormat
   [junit4] IGNOR/A 0.01s J1 | TestCompressingStoredFieldsFormat.testBigDocuments {#0 seed=[443FE98E844B5D4D:B515B3D13767F36A]}
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly)
   [junit4] IGNOR/A 0.01s J1 | TestCompressingStoredFieldsFormat.testBigDocuments {#1 seed=[443FE98E844B5D4D:1430F2D03A53846]}
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly)
   [junit4] IGNOR/A 0.01s J1 | TestCompressingStoredFieldsFormat.testBigDocuments {#2 seed=[443FE98E844B5D4D:8FAA99F15261708D]}
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly)
   [junit4] IGNOR/A 0.01s J1 | TestCompressingStoredFieldsFormat.testBigDocuments {#3 seed=[443FE98E844B5D4D:BE4432143E9F2BA4]}
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly)
   [junit4] IGNOR/A 0.01s J1 | TestCompressingStoredFieldsFormat.testBigDocuments {#4 seed=[443FE98E844B5D4D:F285B7B99F97EB1F]}
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly)
   [junit4] Completed on J1 in 18.60s, 55 tests, 5 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.document.TestBinaryDocument
   [junit4] Completed on J1 in 0.02s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestMixedCodecs
   [junit4] Completed on J1 in 1.62s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterUnicode
   [junit4] Completed on J1 in 3.99s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene41.TestBlockPostingsFormat3
   [junit4] Completed on J0 in 7.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestThreadedForceMerge
   [junit4] Completed on J1 in 0.81s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDirectoryReaderReopen
   [junit4] Completed on J1 in 2.25s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestPositionIncrement
   [junit4] Completed on J1 in 0.11s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestWindowsMMap
   [junit4] Completed on J1 in 0.26s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestVersionComparator
   [junit4] Completed on J1 in 0.06s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestStressNRT
   [junit4] Completed on J0 in 4.71s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.automaton.TestSpecialOperations
   [junit4] Completed on J0 in 0.17s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestMaxTermFrequency
   [junit4] Completed on J0 in 0.19s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestAtomicUpdate
   [junit4] Completed on J1 in 4.58s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestTopDocsMerge
   [junit4] Completed on J0 in 19.85s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.packed.TestPackedInts
   [junit4] IGNOR/A 0.00s J1 | TestPackedInts.testBlockReaderOverflow
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly)
   [junit4] Completed on J1 in 19.30s, 27 tests, 3 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestMultiFields
   [junit4] Completed on J0 in 2.65s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestMultiTermQueryRewrites
   [junit4] Completed on J0 in 0.11s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSloppyPhraseQuery2
   [junit4] Completed on J1 in 0.98s, 9 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestLogMergePolicy
   [junit4] Completed on J1 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.junitcompat.TestSetupTeardownChaining
   [junit4] Completed on J1 in 0.05s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTerm
   [junit4] Completed on J1 in 0.01s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestBooleanScorer
   [junit4] Completed on J1 in 0.03s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestSmallFloat
   [junit4] Completed on J1 in 0.13s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestPersistentSnapshotDeletionPolicy
   [junit4] Completed on J0 in 2.48s, 13 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene40.TestLucene40TermVectorsFormat
   [junit4] Completed on J1 in 7.39s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestNGramPhraseQuery
   [junit4] Completed on J1 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestDocValuesScoring
   [junit4] Completed on J1 in 0.12s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestFieldInfos
   [junit4] Completed on J1 in 0.01s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestPositiveScoresOnlyCollector
   [junit4] Completed on J1 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestFieldCache
   [junit4] Completed on J1 in 1.68s, 10 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestTotalHitCountCollector
   [junit4] Completed on J1 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene3x.TestLucene3xTermVectorsFormat
   [junit4] Completed on J1 in 7.11s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDocumentsWriterStallControl
   [junit4] Completed on J0 in 16.08s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestFieldCacheSanityChecker
   [junit4] Completed on J0 in 0.66s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestComplexExplanationsOfNonMatches
   [junit4] Completed on J0 in 0.11s, 22 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterLockRelease
   [junit4] Completed on J0 in 0.01s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestBagOfPositions
   [junit4] Completed on J0 in 20.68s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestOpenBitSet
   [junit4] Completed on J1 in 22.80s, 9 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestQueryWrapperFilter
   [junit4] Completed on J1 in 0.30s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDocInverterPerFieldErrorInfo
   [junit4] Completed on J1 in 0.03s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestMockDirectoryWrapper
   [junit4] Completed on J1 in 0.02s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIntBlockPool
   [junit4] Completed on J1 in 0.80s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestIntroSorter
   [junit4] Completed on J1 in 0.15s, 9 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestAutomatonQuery
   [junit4] Completed on J1 in 0.18s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSimpleExplanationsOfNonMatches
   [junit4] Completed on J1 in 0.26s, 69 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestBooleanMinShouldMatch
   [junit4] Completed on J0 in 3.50s, 17 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterCommit
   [junit4] Completed on J0 in 2.10s, 12 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.analysis.TestMockCharFilter
   [junit4] Completed on J0 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestParallelAtomicReader
   [junit4] Completed on J0 in 0.47s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestSpanFirstQuery
   [junit4] Completed on J0 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSortRandom
   [junit4] Completed on J0 in 0.46s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestWildcardRandom
   [junit4] Completed on J0 in 0.11s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.automaton.TestDeterminism
   [junit4] Completed on J0 in 0.67s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.Test2BPositions
   [junit4] Completed on J0 in 0.01s, 1 test, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterExceptions
   [junit4] Completed on J1 in 17.17s, 27 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestIntsRef
   [junit4] Completed on J1 in 0.02s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.document.TestField
   [junit4] Completed on J1 in 0.06s, 18 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestSpansAdvanced
   [junit4] Completed on J1 in 0.06s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestHugeRamFile
   [junit4] Completed on J1 in 1.25s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.analysis.TestCharFilter
   [junit4] Completed on J1 in 0.54s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestUnicodeUtil
   [junit4] Completed on J1 in 1.21s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestTermRangeFilter
   [junit4] Completed on J1 in 0.96s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestMultiDocValues
   [junit4] IGNOR/A 0.01s J1 | TestMultiDocValues.testSortedSetWithDups
   [junit4]    > Assumption #1: codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestMultiDocValues.testDocsWithField
   [junit4]    > Assumption #1: codec does not support docsWithField
   [junit4] IGNOR/A 0.01s J1 | TestMultiDocValues.testSortedSet
   [junit4]    > Assumption #1: codec does not support SORTED_SET
   [junit4] Completed on J1 in 4.18s, 7 tests, 3 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestNearSpansOrdered
   [junit4] Completed on J1 in 0.18s, 10 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.Test4GBStoredFields
   [junit4] IGNOR/A 0.00s J1 | Test4GBStoredFields.test
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly)
   [junit4] Completed on J1 in 0.01s, 1 test, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSortDocValues
   [junit4] Completed on J1 in 0.32s, 27 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.junitcompat.TestJUnitRuleOrder
   [junit4] Completed on J1 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestCheckIndex
   [junit4] Completed on J1 in 0.06s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.analysis.TestMockAnalyzer
   [junit4] Completed on J0 in 20.94s, 17 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.junitcompat.TestSeedFromUncaught
   [junit4] Completed on J0 in 0.09s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestFuzzyQuery
   [junit4] Completed on J1 in 0.34s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestBytesRef
   [junit4] Completed on J0 in 0.04s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.Test2BTerms
   [junit4] Completed on J0 in 0.01s, 1 test, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.junitcompat.TestFailOnFieldCacheInsanity
   [junit4] Completed on J0 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDocValuesFormat
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testTwoBytesOneMissingWithMerging
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testSortedSetTwoFields
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testSortedSetTwoDocumentsMerged
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testSortedSetThreeValuesTwoDocs
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testSortedSetFixedLengthVsStoredFields
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testByteMissingVsFieldCache
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testSortedSetFixedLengthSingleValuedVsStoredFields
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testSortedSetVariableLengthSingleValuedVsStoredFields
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.00s J1 | TestDocValuesFormat.testSortedSetFixedLengthVsUninvertedField
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testSortedSetTwoDocumentsFirstMissingMerge
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testLongMissingVsFieldCache
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testTwoNumbersOneMissingWithMerging
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testSortedSetOneValue
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testSortedSetTwoDocumentsFirstMissing
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testSortedSetVariableLengthVsStoredFields
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testSortedSetTwoDocumentsLastMissing
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testThreads2
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testSortedSetTwoValuesUnordered
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testTwoNumbersOneMissing
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testShortMissingVsFieldCache
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testThreeNumbersOneMissingWithMerging
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testSortedSetTwoDocumentsLastMissingMerge
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testSortedSetVariableLengthVsUninvertedField
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.00s J1 | TestDocValuesFormat.testSortedSetTermsEnum
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.00s J1 | TestDocValuesFormat.testSortedSetMergeAwayAllValues
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.00s J1 | TestDocValuesFormat.testIntMissingVsFieldCache
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testSortedSetTwoValues
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testThreeBytesOneMissingWithMerging
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J1 | TestDocValuesFormat.testTwoBytesOneMissing
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] Completed on J1 in 12.17s, 78 tests, 29 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTermVectorsFormat
   [junit4] Completed on J1 in 7.12s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.fst.TestFSTs
   [junit4] IGNOR/A 0.00s J1 | TestFSTs.testBigSet
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly)
   [junit4] Completed on J1 in 30.17s, 18 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestNumericRangeQuery64
   [junit4] Completed on J1 in 13.61s, 34 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.fst.TestBytesStore
   [junit4] Completed on J1 in 11.20s, 1 test
   [junit4] 
   [junit4] HEARTBEAT J0 PID(12284@serv1.sd-datasolutions.de): 2014-03-01T01:09:34, stalled for 66.1s at: TestNumericDocValuesUpdates.testTonsOfUpdates
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterWithThreads
   [junit4] Completed on J1 in 6.17s, 12 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestNumericRangeQuery32
   [junit4] Completed on J1 in 9.05s, 27 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestBackwardsCompatibility
   [junit4] Completed on J1 in 10.16s, 15 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.analysis.TestGraphTokenizers
   [junit4] Completed on J1 in 20.35s, 21 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.analysis.TestLookaheadTokenFilter
   [junit4] Completed on J1 in 8.65s, 3 tests
   [junit4] 
   [junit4] HEARTBEAT J0 PID(12284@serv1.sd-datasolutions.de): 2014-03-01T01:10:34, stalled for  126s at: TestNumericDocValuesUpdates.testTonsOfUpdates
   [junit4] Suite: org.apache.lucene.store.TestMultiMMap
   [junit4] Completed on J1 in 8.46s, 11 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDeletionPolicy
   [junit4] Completed on J1 in 4.65s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestBooleanOr
   [junit4] Completed on J1 in 1.06s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestBasics
   [junit4] Completed on J1 in 3.58s, 28 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestFlushByRamOrCountsPolicy
   [junit4] Completed on J1 in 2.30s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterDelete
   [junit4] IGNOR/A 0.00s J1 | TestIndexWriterDelete.testApplyDeletesOnFlush
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly)
   [junit4] Completed on J1 in 5.47s, 22 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene40.TestLucene40DocValuesFormat
   [junit4] IGNOR/A 0.01s J1 | TestLucene40DocValuesFormat.testTwoBytesOneMissingWithMerging
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J1 | TestLucene40DocValuesFormat.testSortedSetTwoFields
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestLucene40DocValuesFormat.testSortedSetTwoDocumentsMerged
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestLucene40DocValuesFormat.testSortedSetThreeValuesTwoDocs
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestLucene40DocValuesFormat.testSortedSetFixedLengthVsStoredFields
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.00s J1 | TestLucene40DocValuesFormat.testByteMissingVsFieldCache
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J1 | TestLucene40DocValuesFormat.testSortedSetFixedLengthSingleValuedVsStoredFields
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestLucene40DocValuesFormat.testSortedSetVariableLengthSingleValuedVsStoredFields
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestLucene40DocValuesFormat.testSortedSetFixedLengthVsUninvertedField
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestLucene40DocValuesFormat.testSortedSetTwoDocumentsFirstMissingMerge
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestLucene40DocValuesFormat.testLongMissingVsFieldCache
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J1 | TestLucene40DocValuesFormat.testTwoNumbersOneMissingWithMerging
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J1 | TestLucene40DocValuesFormat.testSortedSetOneValue
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestLucene40DocValuesFormat.testSortedSetTwoDocumentsFirstMissing
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.00s J1 | TestLucene40DocValuesFormat.testSortedSetVariableLengthVsStoredFields
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestLucene40DocValuesFormat.testSortedSetTwoDocumentsLastMissing
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.00s J1 | TestLucene40DocValuesFormat.testThreads2
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.00s J1 | TestLucene40DocValuesFormat.testSortedSetTwoValuesUnordered
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.00s J1 | TestLucene40DocValuesFormat.testTwoNumbersOneMissing
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J1 | TestLucene40DocValuesFormat.testShortMissingVsFieldCache
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.01s J1 | TestLucene40DocValuesFormat.testThreeNumbersOneMissingWithMerging
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.00s J1 | TestLucene40DocValuesFormat.testSortedSetTwoDocumentsLastMissingMerge
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestLucene40DocValuesFormat.testSortedSetVariableLengthVsUninvertedField
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.01s J1 | TestLucene40DocValuesFormat.testSortedSetTermsEnum
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.00s J1 | TestLucene40DocValuesFormat.testSortedSetMergeAwayAllValues
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.00s J1 | TestLucene40DocValuesFormat.testIntMissingVsFieldCache
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.00s J1 | TestLucene40DocValuesFormat.testSortedSetTwoValues
   [junit4]    > Assumption #1: Codec does not support SORTED_SET
   [junit4] IGNOR/A 0.00s J1 | TestLucene40DocValuesFormat.testThreeBytesOneMissingWithMerging
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] IGNOR/A 0.00s J1 | TestLucene40DocValuesFormat.testTwoBytesOneMissing
   [junit4]    > Assumption #1: Codec does not support getDocsWithField
   [junit4] Completed on J1 in 11.20s, 78 tests, 29 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestNumericDocValuesUpdates
   [junit4] Completed on J0 in 171.41s, 31 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestSegmentTermEnum
   [junit4] Completed on J0 in 0.04s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSimpleExplanations
   [junit4] Completed on J0 in 1.66s, 69 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestNRTThreads
   [junit4] Completed on J1 in 7.30s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestBoolean2
   [junit4] Completed on J1 in 3.33s, 11 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterMerging
   [junit4] Completed on J0 in 7.83s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.TestMergeSchedulerExternal
   [junit4] Completed on J0 in 0.39s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestStressAdvance
   [junit4] Completed on J1 in 5.22s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestNorms
   [junit4] Completed on J1 in 1.62s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriter
   [junit4] Completed on J0 in 31.29s, 59 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIsCurrent
   [junit4] Completed on J0 in 0.14s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestPhraseQuery
   [junit4] Completed on J0 in 1.97s, 18 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterForceMerge
   [junit4] Completed on J0 in 2.27s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestCrash
   [junit4] Completed on J0 in 0.52s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestCompoundFile
   [junit4] Completed on J0 in 1.11s, 18 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestPhrasePrefixQuery
   [junit4] Completed on J0 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.Test2BSortedDocValues
   [junit4] Completed on J0 in 0.00s, 0 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.analysis.tokenattributes.TestCharTermAttributeImpl
   [junit4] Completed on J0 in 0.50s, 12 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestCloseableThreadLocal
   [junit4] Completed on J0 in 0.02s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestPostingsFormat
   [junit4] Completed on J0 in 1.70s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSearchAfter
   [junit4] Completed on J1 in 36.98s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSloppyPhraseQuery
   [junit4] Completed on J0 in 3.08s, 9 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestRegexpRandom
   [junit4] Completed on J0 in 0.11s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterConfig
   [junit4] Completed on J0 in 0.05s, 9 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestConcurrentMergeScheduler
   [junit4] Completed on J1 in 2.78s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.compressing.TestHighCompressionMode
   [junit4] Completed on J1 in 5.12s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterReader
   [junit4] Completed on J0 in 7.43s, 23 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene3x.TestLucene3xPostingsFormat
   [junit4] Completed on J0 in 2.37s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestMultiPhraseQuery
   [junit4] Completed on J0 in 0.43s, 17 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestNeverDelete
   [junit4] Completed on J1 in 4.27s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestStressIndexing
   [junit4] Completed on J1 in 4.49s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSearcherManager
   [junit4] Completed on J0 in 7.30s, 8 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTransactionRollback
   [junit4] Completed on J0 in 0.36s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestFilterDirectory
   [junit4] Completed on J0 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSimilarityProvider
   [junit4] Completed on J0 in 0.03s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestRollingUpdates
   [junit4] Completed on J1 in 2.03s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.packed.TestEliasFanoDocIdSet
   [junit4] Completed on J0 in 0.49s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestPrefixInBooleanQuery
   [junit4] Completed on J0 in 1.13s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene41.TestBlockPostingsFormat2
   [junit4] Completed on J1 in 1.85s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestDocTermOrdsRewriteMethod
   [junit4] Completed on J1 in 3.25s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestSnapshotDeletionPolicy
   [junit4] Completed on J1 in 2.15s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene40.TestLucene40PostingsReader
   [junit4] Completed on J1 in 3.90s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestNRTReaderWithThreads
   [junit4] Completed on J1 in 1.22s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.perfield.TestPerFieldPostingsFormat
   [junit4] Completed on J1 in 1.59s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestArrayUtil
   [junit4] Completed on J1 in 3.63s, 11 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene3x.TestLucene3xStoredFieldsFormat
   [junit4] IGNOR/A 0.02s J0 | TestLucene3xStoredFieldsFormat.testWriteReadMerge
   [junit4]    > Assumption #1: impersonation isnt good enough
   [junit4] IGNOR/A 0.01s J0 | TestLucene3xStoredFieldsFormat.testBigDocuments
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly)
   [junit4] Completed on J0 in 23.99s, 10 tests, 2 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.analysis.tokenattributes.TestSimpleAttributeImpl
   [junit4] Completed on J0 in 0.01s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSimilarity
   [junit4] Completed on J0 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestByteSlices
   [junit4] Completed on J1 in 7.24s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestBufferedIndexInput
   [junit4] Completed on J0 in 0.31s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestConsistentFieldNumbers
   [junit4] Completed on J0 in 3.77s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestWeakIdentityMap
   [junit4] Completed on J0 in 9.10s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTermsEnum
   [junit4] Completed on J1 in 14.88s, 9 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestDocTermOrdsRangeFilter
   [junit4] Completed on J0 in 1.45s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestSegmentMerger
   [junit4] Completed on J1 in 0.50s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestOmitNorms
   [junit4] Completed on J0 in 0.40s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestDoubleBarrelLRUCache
   [junit4] Completed on J1 in 1.02s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestComplexExplanations
   [junit4] Completed on J0 in 1.47s, 22 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestNRTCachingDirectory
   [junit4] Completed on J0 in 0.36s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestRegexpRandom2
   [junit4] Completed on J1 in 2.83s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterNRTIsCurrent
   [junit4] Completed on J0 in 4.32s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestMultiThreadTermVectors
   [junit4] Completed on J0 in 0.35s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.perfield.TestPerFieldPostingsFormat2
   [junit4] Completed on J0 in 4.93s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSort
   [junit4] Completed on J0 in 0.92s, 53 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestPagedBytes
   [junit4] Completed on J1 in 10.24s, 3 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene40.TestBitVector
   [junit4] Completed on J0 in 1.41s, 9 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestFieldsReader
   [junit4] Completed on J0 in 0.28s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene40.TestReuseDocsEnum
   [junit4] Completed on J1 in 0.97s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSimpleSearchEquivalence
   [junit4] Completed on J0 in 0.55s, 12 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDocValuesIndexing
   [junit4] Completed on J1 in 0.67s, 30 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.similarities.TestSimilarityBase
   [junit4] Completed on J0 in 0.55s, 30 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTermsEnum2
   [junit4] Completed on J1 in 0.99s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.Test2BDocs
   [junit4] Completed on J1 in 0.59s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterOnDiskFull
   [junit4] Completed on J1 in 0.47s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestNumericUtils
   [junit4] Completed on J0 in 2.60s, 12 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestCustomNorms
   [junit4] Completed on J1 in 0.79s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestPayloadSpans
   [junit4] Completed on J0 in 0.58s, 10 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestFlex
   [junit4] Completed on J0 in 0.16s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene40.TestLucene40PostingsFormat
   [junit4] Completed on J1 in 1.44s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDocTermOrds
   [junit4] Completed on J1 in 1.26s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestSpanExplanations
   [junit4] Completed on J0 in 2.35s, 31 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestMaxFailuresRule
   [junit4] Completed on J1 in 0.82s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestStressIndexing2
   [junit4] Completed on J0 in 0.87s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestRAMDirectory
   [junit4] Completed on J1 in 0.34s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTermVectorsWriter
   [junit4] Completed on J0 in 0.41s, 13 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestCodecs
   [junit4] Completed on J1 in 0.46s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestOmitPositions
   [junit4] Completed on J0 in 0.49s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestCopyBytes
   [junit4] Completed on J0 in 0.62s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestForceMergeForever
   [junit4] Completed on J0 in 0.41s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestBytesRefHash
   [junit4] Completed on J1 in 1.67s, 8 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestTermRangeQuery
   [junit4] Completed on J1 in 0.13s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestOmitTf
   [junit4] Completed on J0 in 0.34s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.payloads.TestPayloadNearQuery
   [junit4] Completed on J1 in 0.18s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDocumentWriter
   [junit4] Completed on J0 in 0.19s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestForTooMuchCloning
   [junit4] Completed on J1 in 0.16s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.junitcompat.TestReproduceMessage
   [junit4] Completed on J0 in 0.38s, 21 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestSpanSearchEquivalence
   [junit4] Completed on J1 in 0.32s, 8 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDoc
   [junit4] Completed on J1 in 0.10s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestPayloads
   [junit4] Completed on J0 in 0.48s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestWildcard
   [junit4] Completed on J1 in 0.13s, 8 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.similarities.TestSimilarity2
   [junit4] Completed on J0 in 0.20s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestFieldMaskingSpanQuery
   [junit4] Completed on J1 in 0.30s, 11 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTermVectorsReader
   [junit4] Completed on J1 in 0.05s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestSpansAdvanced2
   [junit4] Completed on J1 in 0.11s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.TestExternalCodecs
   [junit4] Completed on J0 in 0.81s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestTopDocsCollector
   [junit4] Completed on J0 in 0.20s, 8 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestUniqueTermCount
   [junit4] Completed on J0 in 0.09s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestMultiValuedNumericRangeQuery
   [junit4] Completed on J1 in 0.92s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.automaton.TestBasicOperations
   [junit4] Completed on J0 in 0.34s, 8 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestAllFilesHaveCodecHeader
   [junit4] Completed on J0 in 0.16s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestPrefixCodedTerms
   [junit4] Completed on J1 in 0.30s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestParallelReaderEmptyIndex
   [junit4] Completed on J0 in 0.08s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene41.TestForUtil
   [junit4] Completed on J1 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestTermScorer
   [junit4] Completed on J0 in 0.08s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestTopFieldCollector
   [junit4] Completed on J1 in 0.11s, 8 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestFileSwitchDirectory
   [junit4] Completed on J0 in 0.04s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestSumDocFreq
   [junit4] Completed on J1 in 0.09s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestSentinelIntSet
   [junit4] Completed on J0 in 0.15s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestDirectory
   [junit4] IGNOR/A 0.00s J0 | TestDirectory.testThreadSafety
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly)
   [junit4] Completed on J0 in 0.32s, 8 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestMultiLevelSkipList
   [junit4] Completed on J0 in 0.11s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestPayloadsOnVectors
   [junit4] Completed on J0 in 0.08s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.junitcompat.TestExceptionInBeforeClassHooks
   [junit4] Completed on J0 in 0.26s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestBooleanQueryVisitSubscorers
   [junit4] Completed on J0 in 0.03s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.TestSearchForDuplicates
   [junit4] Completed on J0 in 0.08s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.junitcompat.TestSystemPropertiesInvariantRule
   [junit4] Completed on J0 in 0.11s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestSizeBoundedForceMerge
   [junit4] Completed on J0 in 0.09s, 11 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexFileDeleter
   [junit4] Completed on J0 in 0.03s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestPrefixRandom
   [junit4] Completed on J1 in 2.80s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestConstantScoreQuery
   [junit4] Completed on J1 in 0.04s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.automaton.TestCompiledAutomaton
   [junit4] Completed on J0 in 0.30s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestPrefixQuery
   [junit4] Completed on J1 in 0.01s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDocValuesWithThreads
   [junit4] Completed on J0 in 0.09s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.junitcompat.TestBeforeAfterOverrides
   [junit4] Completed on J1 in 0.03s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestParallelTermEnum
   [junit4] Completed on J0 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestElevationComparator
   [junit4] Completed on J1 in 0.07s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestFilteredSearch
   [junit4] Completed on J0 in 0.04s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestConjunctions
   [junit4] Completed on J1 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.junitcompat.TestSameRandomnessLocalePassedOrNot
   [junit4] Completed on J0 in 0.03s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestDateSort
   [junit4] Completed on J1 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestIdentityHashSet
   [junit4] Completed on J0 in 0.12s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestSpanExplanationsOfNonMatches
   [junit4] Completed on J1 in 0.09s, 31 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestVirtualMethod
   [junit4] Completed on J0 in 0.02s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.analysis.TestNumericTokenStream
   [junit4] Completed on J1 in 0.02s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestSetOnce
   [junit4] Completed on J0 in 0.04s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestFilterAtomicReader
   [junit4] Completed on J1 in 0.04s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.TestSearch
   [junit4] Completed on J0 in 0.04s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestDateFilter
   [junit4] Completed on J1 in 0.02s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestCharsRef
   [junit4] Completed on J0 in 0.07s, 8 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.Test2BPostings
   [junit4] IGNOR/A 0.04s J1 | Test2BPostings.test
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly)
   [junit4] Completed on J1 in 0.05s, 1 test, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDocCount
   [junit4] Completed on J0 in 0.07s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestCachingCollector
   [junit4] Completed on J1 in 0.03s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestFieldCacheTermsFilter
   [junit4] Completed on J0 in 0.07s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestRecyclingByteBlockAllocator
   [junit4] Completed on J1 in 0.04s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestLock
   [junit4] Completed on J0 in 0.03s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestRamUsageEstimator
   [junit4] Completed on J1 in 0.02s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.junitcompat.TestFailIfUnreferencedFiles
   [junit4] Completed on J0 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestNoMergeScheduler
   [junit4] Completed on J1 in 0.02s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestByteBlockPool
   [junit4] Completed on J0 in 0.07s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.junitcompat.TestLeaveFilesIfTestFails
   [junit4] Completed on J1 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.TestDemo
   [junit4] Completed on J0 in 0.01s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.TestAssertions
   [junit4] Completed on J1 in 0.01s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTwoPhaseCommitTool
   [junit4] Completed on J0 in 0.02s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestNot
   [junit4] Completed on J1 in 0.07s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterOnJRECrash
   [junit4] IGNOR/A 0.00s J0 | TestIndexWriterOnJRECrash.testNRTThreads
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly)
   [junit4] Completed on J0 in 0.01s, 1 test, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestPrefixFilter
   [junit4] Completed on J1 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestVersion
   [junit4] Completed on J0 in 0.02s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.junitcompat.TestCodecReported
   [junit4] Completed on J1 in 0.01s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestCodecHoldsOpenFiles
   [junit4] Completed on J0 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestReaderClosed
   [junit4] Completed on J1 in 0.03s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.MultiCollectorTest
   [junit4] Completed on J0 in 0.02s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestDocBoost
   [junit4] Completed on J1 in 0.01s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestScoreCachingWrappingScorer
   [junit4] Completed on J0 in 0.01s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.junitcompat.TestFailIfDirectoryNotClosed
   [junit4] Completed on J1 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTermdocPerf
   [junit4] Completed on J0 in 0.01s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexCommit
   [junit4] Completed on J1 in 0.01s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.Test2BPostingsBytes
   [junit4] Completed on J0 in 0.01s, 1 test, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestTopScoreDocCollector
   [junit4] Completed on J1 in 0.01s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestNewestSegment
   [junit4] Completed on J0 in 0.01s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.Test2BNumericDocValues
   [junit4] Completed on J1 in 0.00s, 0 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.Test2BBinaryDocValues
   [junit4] Completed on J0 in 0.00s, 0 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.Test2BPagedBytes
   [junit4] Completed on J1 in 0.00s, 0 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.fst.Test2BFST
   [junit4] Completed on J0 in 0.00s, 0 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.analysis.TestPosition
   [junit4] Completed on J1 in 0.00s, 0 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.analysis.TestReusableStringReader
   [junit4] Completed on J0 in 0.01s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene3x.TestImpersonation
   [junit4] Completed on J1 in 0.01s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene3x.TestSurrogates
   [junit4] Completed on J0 in 0.67s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene3x.TestTermInfosReaderIndex
   [junit4] Completed on J1 in 0.68s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene41.TestLucene41StoredFieldsFormat
   [junit4] IGNOR/A 0.00s J0 | TestLucene41StoredFieldsFormat.testBigDocuments
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly)
   [junit4] Completed on J0 in 4.09s, 10 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestBackwardsCompatibility3x
   [junit4] Completed on J1 in 5.52s, 16 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestStoredFieldsFormat
   [junit4] IGNOR/A 0.00s J1 | TestStoredFieldsFormat.testBigDocuments
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly)
   [junit4] Completed on J1 in 3.38s, 10 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTryDelete
   [junit4] Completed on J1 in 0.02s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.FuzzyTermOnShortTermsTest
   [junit4] Completed on J1 in 0.10s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterOutOfFileDescriptors
   [junit4] Completed on J0 in 6.83s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestEarlyTermination
   [junit4] Completed on J0 in 0.03s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestIndexSearcher
   [junit4] Completed on J0 in 0.23s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestMinShouldMatch2
   [junit4] Completed on J0 in 4.49s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestBytesRefArray
   [junit4] Completed on J0 in 0.12s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestDocIdBitSet
   [junit4] Completed on J0 in 0.71s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestInPlaceMergeSorter
   [junit4] Completed on J0 in 0.29s, 9 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestControlledRealTimeReopenThread
   [junit4] Completed on J1 in 8.33s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestMergedIterator
   [junit4] Completed on J1 in 0.30s, 25 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestOfflineSorter
   [junit4] IGNOR/A 0.00s J1 | TestOfflineSorter.testLargerRandom
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly)
   [junit4] Completed on J1 in 5.48s, 6 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestPForDeltaDocIdSet
   [junit4] Completed on J1 in 0.57s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestLongBitSet
   [junit4] Completed on J0 in 8.17s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.junitcompat.TestReproduceMessageWithRepeated
   [junit4] Completed on J0 in 0.04s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestWAH8DocIdSet
   [junit4] Completed on J1 in 1.43s, 6 tests
   [junit4] 
   [junit4] JVM J0:     1.08 ..   638.44 =   637.36s
   [junit4] JVM J1:     1.09 ..   638.72 =   637.63s
   [junit4] Execution time total: 10 minutes 38 seconds
   [junit4] Tests summary: 385 suites, 2793 tests, 107 ignored (94 assumptions)
     [echo] 5 slowest tests:
[junit4:tophints] 171.41s | org.apache.lucene.index.TestNumericDocValuesUpdates
[junit4:tophints]  54.08s | org.apache.lucene.codecs.perfield.TestPerFieldDocValuesFormat
[junit4:tophints]  41.19s | org.apache.lucene.codecs.compressing.TestCompressingTermVectorsFormat
[junit4:tophints]  36.98s | org.apache.lucene.search.TestSearchAfter
[junit4:tophints]  35.74s | org.apache.lucene.codecs.lucene42.TestLucene42DocValuesFormat

-check-totals:

test:

compile-test:

ivy-availability-check:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/ivy-settings.xml

resolve:

init:

-clover.disable:

-clover.load:

-clover.classpath:

-clover.setup:

clover:

compile-core:

compile-test-framework:

ivy-availability-check:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/ivy-settings.xml

resolve:

init:

compile-lucene-core:

ivy-availability-check:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/ivy-settings.xml

resolve:

init:

-clover.disable:

-clover.load:

-clover.classpath:

-clover.setup:

clover:

compile-core:

compile-codecs:
     [echo] Building codecs...

ivy-availability-check:
     [echo] Building codecs...

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/ivy-settings.xml

resolve:

common.init:

compile-lucene-core:

init:

-clover.disable:

-clover.load:

-clover.classpath:

-clover.setup:

clover:

compile-core:

-clover.disable:

-clover.load:

-clover.classpath:

-clover.setup:

clover:

common.compile-core:

compile-core:

compile-test:

compile-test:
     [echo] Building analyzers-common...

ivy-availability-check:
     [echo] Building analyzers-common...

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/ivy-settings.xml

resolve:

common.init:

compile-lucene-core:

ivy-availability-check:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/ivy-settings.xml

resolve:

init:

-clover.disable:

-clover.load:

-clover.classpath:

-clover.setup:

clover:

compile-core:

init:

compile-test:
     [echo] Building analyzers-common...

ivy-availability-check:

ivy-configure:
[ivy:configure] :: loading settings :: file = /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linu

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

 P34802 oasc.SyncStrategy.sync WARN Closed, skipping sync up.
   [junit4]   2> 65988 T165 oasc.ShardLeaderElectionContext.rejoinLeaderElection Not rejoining election because CoreContainer is shutdown
   [junit4]   2> 65989 T165 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@7eeee0a8
   [junit4]   2> 65991 T165 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=6,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=2,cumulative_deletesById=1,cumulative_deletesByQuery=2,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=5}
   [junit4]   2> 65992 T165 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 65992 T165 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 65993 T165 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 65996 T165 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 65996 T165 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 65997 T165 oasc.CachingDirectoryFactory.closeCacheValue looking to close ./org.apache.solr.client.solrj.impl.CloudSolrServerTest-1393638762808/jetty4/index [CachedDir<<refCount=0;path=./org.apache.solr.client.solrj.impl.CloudSolrServerTest-1393638762808/jetty4/index;done=false>>]
   [junit4]   2> 65997 T165 oasc.CachingDirectoryFactory.close Closing directory: ./org.apache.solr.client.solrj.impl.CloudSolrServerTest-1393638762808/jetty4/index
   [junit4]   2> 65997 T165 oasc.CachingDirectoryFactory.closeCacheValue looking to close ./org.apache.solr.client.solrj.impl.CloudSolrServerTest-1393638762808/jetty4 [CachedDir<<refCount=0;path=./org.apache.solr.client.solrj.impl.CloudSolrServerTest-1393638762808/jetty4;done=false>>]
   [junit4]   2> 65998 T165 oasc.CachingDirectoryFactory.close Closing directory: ./org.apache.solr.client.solrj.impl.CloudSolrServerTest-1393638762808/jetty4
   [junit4]   2> 65998 T165 oascc.ZkStateReader$3.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
   [junit4]   2> 65998 T165 oasc.LeaderElector$1.process WARN  org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /overseer_elect/election
   [junit4]   2> 	at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
   [junit4]   2> 	at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
   [junit4]   2> 	at org.apache.zookeeper.ZooKeeper.getChildren(ZooKeeper.java:1468)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:257)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:254)
   [junit4]   2> 	at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:73)
   [junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient.getChildren(SolrZkClient.java:254)
   [junit4]   2> 	at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:92)
   [junit4]   2> 	at org.apache.solr.cloud.LeaderElector.access$000(LeaderElector.java:55)
   [junit4]   2> 	at org.apache.solr.cloud.LeaderElector$1.process(LeaderElector.java:137)
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:519)
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:495)
   [junit4]   2> 
   [junit4]   2> NOTE: test params are: codec=Lucene45, sim=DefaultSimilarity, locale=ar_SA, timezone=Europe/Paris
   [junit4]   2> NOTE: Linux 3.8.0-36-generic amd64/Oracle Corporation 1.7.0_51 (64-bit)/cpus=8,threads=1,free=35346352,total=131072000
   [junit4]   2> NOTE: All tests run in this JVM: [TestCoreAdmin, LargeVolumeJettyTest, AnlysisResponseBaseTest, CloudSolrServerTest]
   [junit4] Completed on J0 in 57.85s, 2 tests, 1 error <<< FAILURES!
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.util.ClientUtilsTest
   [junit4] Completed on J0 in 0.04s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.common.util.TestXMLEscaping
   [junit4] Completed on J0 in 0.05s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.common.util.URLUtilTest
   [junit4] Completed on J0 in 0.01s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.SolrExceptionTest
   [junit4] Completed on J0 in 0.06s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.common.util.TestJavaBinCodec
   [junit4] Completed on J0 in 0.53s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.request.TestUpdateRequestCodec
   [junit4] Completed on J0 in 0.06s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.SolrExampleXMLTest
   [junit4] Completed on J0 in 9.18s, 26 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.response.NoOpResponseParserTest
   [junit4] Completed on J0 in 1.58s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.impl.LBHttpSolrServerTest
   [junit4] Completed on J0 in 0.00s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.embedded.SolrExampleStreamingTest
   [junit4] Completed on J0 in 20.83s, 27 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.TestLBHttpSolrServer
   [junit4] Completed on J1 in 38.07s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.embedded.SolrExampleJettyTest
   [junit4] Completed on J1 in 6.97s, 27 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.embedded.SolrExampleEmbeddedTest
   [junit4] Completed on J1 in 6.65s, 26 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.impl.BasicHttpSolrServerTest
   [junit4] Completed on J1 in 3.04s, 10 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.embedded.SolrExampleStreamingBinaryTest
   [junit4] Completed on J0 in 19.16s, 27 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.embedded.LargeVolumeBinaryJettyTest
   [junit4] Completed on J1 in 1.35s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.embedded.JettyWebappTest
   [junit4] Completed on J0 in 1.26s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.embedded.LargeVolumeEmbeddedTest
   [junit4] Completed on J1 in 1.82s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.common.params.SolrParamTest
   [junit4] Completed on J1 in 0.03s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.response.TestSpellCheckResponse
   [junit4] Completed on J0 in 2.21s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.embedded.TestEmbeddedSolrServer
   [junit4] Completed on J0 in 0.68s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.response.QueryResponseTest
   [junit4] Completed on J0 in 0.11s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.response.TermsResponseTest
   [junit4] Completed on J1 in 1.86s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.beans.TestDocumentObjectBinder
   [junit4] Completed on J1 in 0.04s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.common.util.TestNamedListCodec
   [junit4] Completed on J0 in 0.32s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.SolrQueryTest
   [junit4] Completed on J1 in 0.07s, 15 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.common.util.TestHash
   [junit4] Completed on J0 in 0.08s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.common.util.ContentStreamTest
   [junit4] Completed on J1 in 0.08s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.common.params.ModifiableSolrParamsTest
   [junit4] Completed on J0 in 0.05s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.response.DocumentAnalysisResponseTest
   [junit4] Completed on J1 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.common.SolrDocumentTest
   [junit4] Completed on J0 in 0.04s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.client.solrj.request.SolrPingTest
   [junit4] Completed on J1 in 1.04s, 2 tests
   [junit4] 
   [junit4] 
   [junit4] Tests with failures:
   [junit4]   - org.apache.solr.client.solrj.impl.CloudSolrServerTest.testShutdown
   [junit4] 
   [junit4] 
   [junit4] JVM J0:     1.40 ..   127.55 =   126.15s
   [junit4] JVM J1:     1.40 ..   128.75 =   127.35s
   [junit4] Execution time total: 2 minutes 8 seconds
   [junit4] Tests summary: 48 suites, 280 tests, 1 error

BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:471: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:451: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/extra-targets.xml:37: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:202: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/common-build.xml:490: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1278: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:911: There were test failures: 48 suites, 280 tests, 1 error

Total time: 50 minutes 53 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.7.0_51 -XX:+UseCompressedOops -XX:+UseG1GC -XX:-UseSuperWord
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure