lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@sd-datasolutions.de>
Subject [JENKINS] Lucene-Solr-4.x-Linux (64bit/jdk1.8.0-ea-b58) - Build # 2091 - Failure!
Date Tue, 30 Oct 2012 23:25:45 GMT
Build: http://jenkins.sd-datasolutions.de/job/Lucene-Solr-4.x-Linux/2091/
Java: 64bit/jdk1.8.0-ea-b58 -XX:+UseParallelGC

3 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.LeaderElectionIntegrationTest

Error Message:
Suite timeout exceeded (>= 7200000 msec).

Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
	at __randomizedtesting.SeedInfo.seed([5E015ADAF27D27F0]:0)


FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.LeaderElectionIntegrationTest

Error Message:
Captured an uncaught exception in thread: Thread[id=1985, name=Thread-821, state=RUNNABLE, group=Overseer state updater.]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=1985, name=Thread-821, state=RUNNABLE, group=Overseer state updater.]
Caused by: java.util.NoSuchElementException
	at __randomizedtesting.SeedInfo.seed([5E015ADAF27D27F0]:0)
	at org.apache.solr.cloud.DistributedQueue.remove(DistributedQueue.java:148)
	at org.apache.solr.cloud.Overseer$ClusterStateUpdater.run(Overseer.java:131)
	at java.lang.Thread.run(Thread.java:722)


REGRESSION:  org.apache.solr.cloud.LeaderElectionIntegrationTest.testLeaderElectionAfterClientTimeout

Error Message:
Test abandoned because suite timeout was reached.

Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
	at __randomizedtesting.SeedInfo.seed([5E015ADAF27D27F0]:0)




Build Log:
[...truncated 9128 lines...]
[junit4:junit4] Suite: org.apache.solr.cloud.LeaderElectionIntegrationTest
[junit4:junit4]   2> 2 T1934 oas.SolrTestCaseJ4.setUp ###Starting testSimpleSliceLeaderElection
[junit4:junit4]   2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150
[junit4:junit4]   2> 2 T1934 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4]   2> 3 T1935 oazs.ZooKeeperServer.setTickTime tickTime set to 1000
[junit4:junit4]   2> 3 T1935 oazs.NIOServerCnxn$Factory.<init> binding to port 0.0.0.0/0.0.0.0:0
[junit4:junit4]   2> 4 T1935 oazsp.FileTxnSnapLog.save Snapshotting: 0
[junit4:junit4]   2> 103 T1934 oasc.ZkTestServer.run start zk server on port:34823
[junit4:junit4]   2> 103 T1934 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:34823 sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@447cbed9
[junit4:junit4]   2> 104 T1940 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:34823
[junit4:junit4]   2> 104 T1934 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 104 T1940 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:34823, initiating session
[junit4:junit4]   2> 104 T1936 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:56994
[junit4:junit4]   2> 105 T1936 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:56994
[junit4:junit4]   2> 105 T1938 oazsp.FileTxnLog.append Creating new log file: log.1
[junit4:junit4]   2> 282 T1938 oazs.NIOServerCnxn.finishSessionInit Established session 0x13ab39066f80000 with negotiated timeout 10000 for client /127.0.0.1:56994
[junit4:junit4]   2> 282 T1940 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:34823, sessionid = 0x13ab39066f80000, negotiated timeout = 10000
[junit4:junit4]   2> 282 T1941 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@447cbed9 name:ZooKeeperConnection Watcher:127.0.0.1:34823 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 282 T1934 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 282 T1934 oascc.SolrZkClient.makePath makePath: /solr
[junit4:junit4]   2> 285 T1939 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13ab39066f80000
[junit4:junit4]   2> 285 T1941 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 286 T1936 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:56994 which had sessionid 0x13ab39066f80000
[junit4:junit4]   2> 285 T1934 oaz.ZooKeeper.close Session: 0x13ab39066f80000 closed
[junit4:junit4]   2> 286 T1934 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:34823/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@1d528de1
[junit4:junit4]   2> 287 T1942 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:34823
[junit4:junit4]   2> 287 T1934 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 287 T1942 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:34823, initiating session
[junit4:junit4]   2> 287 T1936 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:56995
[junit4:junit4]   2> 287 T1936 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:56995
[junit4:junit4]   2> 288 T1938 oazs.NIOServerCnxn.finishSessionInit Established session 0x13ab39066f80001 with negotiated timeout 10000 for client /127.0.0.1:56995
[junit4:junit4]   2> 288 T1942 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:34823, sessionid = 0x13ab39066f80001, negotiated timeout = 10000
[junit4:junit4]   2> 288 T1943 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1d528de1 name:ZooKeeperConnection Watcher:127.0.0.1:34823/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 288 T1934 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 288 T1934 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4:junit4]   2> 290 T1934 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4:junit4]   2> 291 T1934 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4:junit4]   2> 291 T1934 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4:junit4]   2> 292 T1934 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 293 T1934 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 294 T1934 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4:junit4]   2> 295 T1934 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4:junit4]   2> 297 T1934 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 297 T1934 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 299 T1934 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4:junit4]   2> 299 T1934 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
[junit4:junit4]   2> 300 T1934 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4:junit4]   2> 301 T1934 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
[junit4:junit4]   2> 302 T1934 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4:junit4]   2> 302 T1934 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
[junit4:junit4]   2> 303 T1934 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 303 T1934 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 304 T1934 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 305 T1934 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 306 T1934 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 306 T1934 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 307 T1934 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4:junit4]   2> 308 T1934 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
[junit4:junit4]   2> 309 T1939 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13ab39066f80001
[junit4:junit4]   2> 310 T1943 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 310 T1936 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:56995 which had sessionid 0x13ab39066f80001
[junit4:junit4]   2> 310 T1934 oaz.ZooKeeper.close Session: 0x13ab39066f80001 closed
[junit4:junit4]   2> 310 T1934 oasc.LeaderElectionIntegrationTest.setUp ####SETUP_START testSimpleSliceLeaderElection
[junit4:junit4]   2> 311 T1934 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 312 T1934 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 312 T1934 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 312 T1934 oasc.CoreContainer.<init> New CoreContainer 723885507
[junit4:junit4]   2> 313 T1934 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 313 T1934 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 330 T1934 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 336 T1934 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:34823/solr
[junit4:junit4]   2> 336 T1934 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:34823/solr sessionTimeout=3000 watcher=org.apache.solr.common.cloud.ConnectionManager@155838a
[junit4:junit4]   2> 337 T1944 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:34823
[junit4:junit4]   2> 337 T1934 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 337 T1944 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:34823, initiating session
[junit4:junit4]   2> 338 T1936 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:56996
[junit4:junit4]   2> 338 T1936 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:56996
[junit4:junit4]   2> 338 T1938 oazs.NIOServerCnxn.finishSessionInit Established session 0x13ab39066f80002 with negotiated timeout 3000 for client /127.0.0.1:56996
[junit4:junit4]   2> 338 T1944 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:34823, sessionid = 0x13ab39066f80002, negotiated timeout = 3000
[junit4:junit4]   2> 339 T1945 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@155838a name:ZooKeeperConnection Watcher:127.0.0.1:34823/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 339 T1934 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 340 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80002 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 340 T1934 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4:junit4]   2> 341 T1934 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:7000_solr
[junit4:junit4]   2> 341 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80002 type:delete cxid:0x7 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:7000_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:7000_solr
[junit4:junit4]   2> 342 T1934 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:7000_solr
[junit4:junit4]   2> 342 T1934 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 343 T1934 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 343 T1934 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 343 T1934 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 343 T1934 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 344 T1934 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 344 T1934 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 344 T1934 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 344 T1934 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 345 T1934 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 347 T1934 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4:junit4]   2> 349 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80002 type:delete cxid:0x15 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer_elect/leader Error:KeeperErrorCode = NoNode for /solr/overseer_elect/leader
[junit4:junit4]   2> 349 T1934 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4]   2> 350 T1934 oasc.Overseer.start Overseer (id=88580575471337474-127.0.0.1:7000_solr-n_0000000000) starting
[junit4:junit4]   2> 350 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80002 type:create cxid:0x1a zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 351 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80002 type:create cxid:0x1b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 351 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80002 type:create cxid:0x1c zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 352 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80002 type:create cxid:0x1d zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 352 T1947 oasc.OverseerCollectionProcessor.run Process current queue of collection messages
[junit4:junit4]   2> 352 T1934 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4:junit4]   2> 353 T1934 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 354 T1946 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4]   2> 356 T1934 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 356 T1934 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 357 T1934 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 357 T1934 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 358 T1934 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 358 T1934 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 358 T1934 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 379 T1934 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 419 T1934 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 420 T1934 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 423 T1934 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 695 T1934 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 699 T1934 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 701 T1934 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 706 T1934 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 708 T1934 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 710 T1934 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 711 T1934 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 712 T1934 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_7000/
[junit4:junit4]   2> 712 T1934 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7fa49941
[junit4:junit4]   2> 713 T1934 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_7000/index/
[junit4:junit4]   2> 713 T1934 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_7000/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 715 T1934 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_7000/index forceNew:false
[junit4:junit4]   2> 717 T1934 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/index7330573314tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@4e518f73),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 717 T1934 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 717 T1934 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 718 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 719 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 719 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 719 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 720 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 720 T1934 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 720 T1934 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 720 T1934 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 721 T1934 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 721 T1934 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 721 T1934 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 722 T1934 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 722 T1934 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 722 T1934 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 722 T1934 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 723 T1934 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 723 T1934 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 723 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 724 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 724 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 724 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 724 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 725 T1934 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 725 T1934 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 725 T1934 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 728 T1934 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 729 T1934 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 730 T1934 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SYNONYMS.TXT, MAPPING-ISOLATIN1ACCENT.TXT, OLD_SYNONYMS.TXT, STOPWORDS.TXT, CURRENCY.XML, SCHEMA.XML, PROTWORDS.TXT, OPEN-EXCHANGE-RATES.JSON]
[junit4:junit4]   2> 731 T1934 oass.SolrIndexSearcher.<init> Opening Searcher@715f034e main
[junit4:junit4]   2> 731 T1934 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 732 T1934 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 732 T1934 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 732 T1934 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 736 T1934 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 754 T1948 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@715f034e main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 757 T1934 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 757 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80002 type:create cxid:0x50 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer/queue Error:KeeperErrorCode = NoNode for /solr/overseer/queue
[junit4:junit4]   2> 759 T1934 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 759 T1934 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:7000/solr shardId:shard1
[junit4:junit4]   2> 759 T1934 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election
[junit4:junit4]   2> 761 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80002 type:delete cxid:0x5f zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/collections/collection1/leaders Error:KeeperErrorCode = NoNode for /solr/collections/collection1/leaders
[junit4:junit4]   2> 761 T1934 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 762 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80002 type:create cxid:0x60 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 856 T1946 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 856 T1946 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7000/solr",
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "state":"down",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7000_solr"}
[junit4:junit4]   2> 857 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80002 type:create cxid:0x67 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer/queue-work Error:KeeperErrorCode = NoNode for /solr/overseer/queue-work
[junit4:junit4]   2> 860 T1945 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (1)
[junit4:junit4]   2> 1263 T1934 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4]   2> 1263 T1934 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 1264 T1934 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:7000/solr/collection1/
[junit4:junit4]   2> 1264 T1934 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4:junit4]   2> 1266 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80002 type:create cxid:0x85 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1362 T1946 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 1365 T1945 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (1)
[junit4:junit4]   2> 1367 T1934 oasc.ZkController.register We are http://127.0.0.1:7000/solr/collection1/ and leader is http://127.0.0.1:7000/solr/collection1/
[junit4:junit4]   2> 1367 T1934 oasc.ZkController.checkRecovery WARNING Skipping recovery according to sys prop solrcloud.skip.autorecovery
[junit4:junit4]   2> 1368 T1934 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 1369 T1934 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 1370 T1934 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 1370 T1934 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 1370 T1934 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 1370 T1934 oasc.CoreContainer.<init> New CoreContainer 873488085
[junit4:junit4]   2> 1370 T1934 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 1371 T1934 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 1388 T1934 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 1397 T1934 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:34823/solr
[junit4:junit4]   2> 1398 T1934 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:34823/solr sessionTimeout=3000 watcher=org.apache.solr.common.cloud.ConnectionManager@400f1a6a
[junit4:junit4]   2> 1405 T1949 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:34823
[junit4:junit4]   2> 1405 T1934 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 1405 T1949 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:34823, initiating session
[junit4:junit4]   2> 1405 T1936 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:56997
[junit4:junit4]   2> 1406 T1936 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:56997
[junit4:junit4]   2> 1406 T1938 oazs.NIOServerCnxn.finishSessionInit Established session 0x13ab39066f80003 with negotiated timeout 3000 for client /127.0.0.1:56997
[junit4:junit4]   2> 1406 T1949 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:34823, sessionid = 0x13ab39066f80003, negotiated timeout = 3000
[junit4:junit4]   2> 1407 T1950 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@400f1a6a name:ZooKeeperConnection Watcher:127.0.0.1:34823/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 1407 T1934 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 1407 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80003 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1407 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80003 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1409 T1934 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:7001_solr
[junit4:junit4]   2> 1409 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80003 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:7001_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:7001_solr
[junit4:junit4]   2> 1409 T1934 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:7001_solr
[junit4:junit4]   2> 1410 T1945 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4:junit4]   2> 1410 T1934 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 1410 T1934 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 1411 T1934 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 1411 T1934 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 1411 T1934 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 1411 T1934 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 1412 T1934 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 1412 T1934 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 1412 T1934 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 1412 T1934 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 1415 T1934 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 1418 T1934 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 1419 T1934 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 1419 T1934 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 1419 T1934 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 1420 T1934 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 1420 T1934 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 1421 T1934 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 1442 T1934 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 1471 T1934 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 1472 T1934 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 1476 T1934 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 1743 T1934 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 1747 T1934 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 1749 T1934 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 1755 T1934 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 1757 T1934 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 1759 T1934 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 1760 T1934 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 1760 T1934 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_7001/
[junit4:junit4]   2> 1760 T1934 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7fa49941
[junit4:junit4]   2> 1761 T1934 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_7001/index/
[junit4:junit4]   2> 1761 T1934 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_7001/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 1762 T1934 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_7001/index forceNew:false
[junit4:junit4]   2> 1765 T1934 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/index7330573315tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@508ba234),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 1766 T1934 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 1766 T1934 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 1767 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 1768 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 1768 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 1768 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 1769 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 1769 T1934 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 1769 T1934 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 1769 T1934 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 1770 T1934 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 1770 T1934 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 1770 T1934 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 1771 T1934 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 1771 T1934 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 1771 T1934 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 1772 T1934 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 1772 T1934 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 1772 T1934 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1772 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1773 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1773 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1773 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1774 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1774 T1934 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1774 T1934 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 1775 T1934 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 1777 T1934 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 1778 T1934 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 1779 T1934 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SYNONYMS.TXT, MAPPING-ISOLATIN1ACCENT.TXT, OLD_SYNONYMS.TXT, STOPWORDS.TXT, CURRENCY.XML, SCHEMA.XML, PROTWORDS.TXT, OPEN-EXCHANGE-RATES.JSON]
[junit4:junit4]   2> 1781 T1934 oass.SolrIndexSearcher.<init> Opening Searcher@39dc07d1 main
[junit4:junit4]   2> 1781 T1934 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.BaseDirectoryWrapper
[junit4:junit4]   2> 1782 T1934 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 1782 T1934 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 1782 T1934 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 1786 T1934 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 1803 T1951 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@39dc07d1 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 1804 T1934 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 1805 T1934 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 1805 T1934 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:7001/solr shardId:shard1
[junit4:junit4]   2> 1806 T1934 oasc.ZkController.register We are http://127.0.0.1:7001/solr/collection1/ and leader is http://127.0.0.1:7000/solr/collection1/
[junit4:junit4]   2> 1807 T1934 oasc.ZkController.checkRecovery WARNING Skipping recovery according to sys prop solrcloud.skip.autorecovery
[junit4:junit4]   2> 1807 T1934 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 1808 T1934 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 1809 T1934 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 1809 T1934 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 1809 T1934 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 1810 T1934 oasc.CoreContainer.<init> New CoreContainer 1238867524
[junit4:junit4]   2> 1810 T1934 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 1810 T1934 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 1824 T1934 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 1830 T1934 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:34823/solr
[junit4:junit4]   2> 1831 T1934 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:34823/solr sessionTimeout=3000 watcher=org.apache.solr.common.cloud.ConnectionManager@7d5ec0ea
[junit4:junit4]   2> 1832 T1952 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:34823
[junit4:junit4]   2> 1831 T1934 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 1832 T1952 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:34823, initiating session
[junit4:junit4]   2> 1832 T1936 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:56998
[junit4:junit4]   2> 1832 T1936 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:56998
[junit4:junit4]   2> 1833 T1938 oazs.NIOServerCnxn.finishSessionInit Established session 0x13ab39066f80004 with negotiated timeout 3000 for client /127.0.0.1:56998
[junit4:junit4]   2> 1833 T1952 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:34823, sessionid = 0x13ab39066f80004, negotiated timeout = 3000
[junit4:junit4]   2> 1833 T1953 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@7d5ec0ea name:ZooKeeperConnection Watcher:127.0.0.1:34823/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 1833 T1934 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 1833 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80004 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1834 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80004 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1834 T1934 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:7002_solr
[junit4:junit4]   2> 1835 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80004 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:7002_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:7002_solr
[junit4:junit4]   2> 1835 T1934 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:7002_solr
[junit4:junit4]   2> 1836 T1950 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4]   2> 1836 T1945 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4]   2> 1836 T1934 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 1836 T1934 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 1837 T1934 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 1837 T1934 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 1837 T1934 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 1837 T1934 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 1838 T1934 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 1838 T1934 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 1838 T1934 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 1838 T1934 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 1841 T1934 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 1844 T1934 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 1844 T1934 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 1845 T1934 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 1845 T1934 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 1845 T1934 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 1846 T1934 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 1846 T1934 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 1867 T1946 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 1867 T1946 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7000/solr",
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "state":"active",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7000_solr"}
[junit4:junit4]   2> 1868 T1934 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 1869 T1946 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7001/solr",
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "state":"down",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7001_solr"}
[junit4:junit4]   2> 1870 T1946 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7001/solr",
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "state":"active",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7001_solr"}
[junit4:junit4]   2> 1872 T1953 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 1872 T1945 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 1872 T1950 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 1898 T1934 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 1899 T1934 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 1902 T1934 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 2158 T1934 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 2162 T1934 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 2164 T1934 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 2172 T1934 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 2175 T1934 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 2178 T1934 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 2179 T1934 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 2180 T1934 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_7002/
[junit4:junit4]   2> 2180 T1934 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7fa49941
[junit4:junit4]   2> 2181 T1934 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_7002/index/
[junit4:junit4]   2> 2182 T1934 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_7002/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 2182 T1934 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_7002/index forceNew:false
[junit4:junit4]   2> 2186 T1934 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@24af39ab lockFactory=org.apache.lucene.store.NativeFSLockFactory@502dc373; maxCacheMB=0.0234375 maxMergeSizeMB=0.1044921875)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 2186 T1934 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 2187 T1934 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 2188 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 2189 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 2189 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 2190 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 2190 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 2190 T1934 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 2190 T1934 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 2191 T1934 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 2191 T1934 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 2191 T1934 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 2192 T1934 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 2192 T1934 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 2192 T1934 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 2193 T1934 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 2193 T1934 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 2193 T1934 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 2193 T1934 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2194 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2194 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2194 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2195 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2195 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2195 T1934 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2196 T1934 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 2196 T1934 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 2198 T1934 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 2199 T1934 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 2200 T1934 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SYNONYMS.TXT, MAPPING-ISOLATIN1ACCENT.TXT, OLD_SYNONYMS.TXT, STOPWORDS.TXT, CURRENCY.XML, SCHEMA.XML, PROTWORDS.TXT, OPEN-EXCHANGE-RATES.JSON]
[junit4:junit4]   2> 2201 T1934 oass.SolrIndexSearcher.<init> Opening Searcher@3b6ec36c main
[junit4:junit4]   2> 2202 T1934 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 2202 T1934 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 2202 T1934 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 2203 T1934 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 2206 T1934 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 2223 T1954 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3b6ec36c main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 2224 T1934 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 2225 T1934 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 2225 T1934 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:7002/solr shardId:shard1
[junit4:junit4]   2> 2227 T1934 oasc.ZkController.register We are http://127.0.0.1:7002/solr/collection1/ and leader is http://127.0.0.1:7000/solr/collection1/
[junit4:junit4]   2> 2227 T1934 oasc.ZkController.checkRecovery WARNING Skipping recovery according to sys prop solrcloud.skip.autorecovery
[junit4:junit4]   2> 2227 T1934 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 2228 T1934 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2229 T1934 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 2230 T1934 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 2230 T1934 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 2230 T1934 oasc.CoreContainer.<init> New CoreContainer 2107628482
[junit4:junit4]   2> 2230 T1934 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 2230 T1934 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 2244 T1934 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 2250 T1934 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:34823/solr
[junit4:junit4]   2> 2250 T1934 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:34823/solr sessionTimeout=3000 watcher=org.apache.solr.common.cloud.ConnectionManager@3271b61c
[junit4:junit4]   2> 2251 T1934 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 2251 T1955 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:34823
[junit4:junit4]   2> 2252 T1955 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:34823, initiating session
[junit4:junit4]   2> 2252 T1936 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:56999
[junit4:junit4]   2> 2252 T1936 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:56999
[junit4:junit4]   2> 2252 T1938 oazs.NIOServerCnxn.finishSessionInit Established session 0x13ab39066f80005 with negotiated timeout 3000 for client /127.0.0.1:56999
[junit4:junit4]   2> 2252 T1955 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:34823, sessionid = 0x13ab39066f80005, negotiated timeout = 3000
[junit4:junit4]   2> 2253 T1956 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@3271b61c name:ZooKeeperConnection Watcher:127.0.0.1:34823/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 2253 T1934 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 2253 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80005 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2254 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80005 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2255 T1934 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:7003_solr
[junit4:junit4]   2> 2255 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80005 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:7003_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:7003_solr
[junit4:junit4]   2> 2255 T1934 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:7003_solr
[junit4:junit4]   2> 2256 T1950 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4]   2> 2256 T1945 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4]   2> 2257 T1953 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4]   2> 2257 T1934 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 2257 T1934 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 2257 T1934 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 2257 T1934 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 2258 T1934 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 2258 T1934 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 2258 T1934 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 2259 T1934 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 2259 T1934 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 2259 T1934 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 2263 T1934 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 2274 T1934 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 2274 T1934 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 2275 T1934 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 2275 T1934 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 2276 T1934 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 2276 T1934 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 2276 T1934 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 2298 T1934 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 2327 T1934 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 2327 T1934 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 2330 T1934 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 2374 T1946 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2375 T1946 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7002/solr",
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "state":"down",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7002_solr"}
[junit4:junit4]   2> 2377 T1946 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7002/solr",
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "state":"active",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7002_solr"}
[junit4:junit4]   2> 2379 T1950 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 2379 T1945 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 2379 T1956 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 2379 T1953 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 2587 T1934 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 2592 T1934 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 2594 T1934 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 2600 T1934 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 2602 T1934 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 2604 T1934 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 2605 T1934 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 2606 T1934 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_7003/
[junit4:junit4]   2> 2606 T1934 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7fa49941
[junit4:junit4]   2> 2607 T1934 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_7003/index/
[junit4:junit4]   2> 2607 T1934 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_7003/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 2608 T1934 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_7003/index forceNew:false
[junit4:junit4]   2> 2608 T1934 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@238419e1 lockFactory=org.apache.lucene.store.NativeFSLockFactory@13fb4b43),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 2609 T1934 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 2609 T1934 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 2610 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 2610 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 2611 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 2611 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 2611 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 2612 T1934 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 2612 T1934 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 2612 T1934 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 2613 T1934 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 2613 T1934 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 2613 T1934 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 2614 T1934 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 2614 T1934 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 2614 T1934 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 2614 T1934 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 2615 T1934 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 2615 T1934 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2615 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2615 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2616 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2616 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2616 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2617 T1934 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2617 T1934 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 2617 T1934 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 2620 T1934 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 2621 T1934 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 2622 T1934 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SYNONYMS.TXT, MAPPING-ISOLATIN1ACCENT.TXT, OLD_SYNONYMS.TXT, STOPWORDS.TXT, CURRENCY.XML, SCHEMA.XML, PROTWORDS.TXT, OPEN-EXCHANGE-RATES.JSON]
[junit4:junit4]   2> 2623 T1934 oass.SolrIndexSearcher.<init> Opening Searcher@485aa56e main
[junit4:junit4]   2> 2623 T1934 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.BaseDirectoryWrapper
[junit4:junit4]   2> 2624 T1934 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 2624 T1934 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 2624 T1934 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 2627 T1934 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 2643 T1957 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@485aa56e main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 2645 T1934 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 2645 T1934 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 2646 T1934 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:7003/solr shardId:shard1
[junit4:junit4]   2> 2647 T1934 oasc.ZkController.register We are http://127.0.0.1:7003/solr/collection1/ and leader is http://127.0.0.1:7000/solr/collection1/
[junit4:junit4]   2> 2647 T1934 oasc.ZkController.checkRecovery WARNING Skipping recovery according to sys prop solrcloud.skip.autorecovery
[junit4:junit4]   2> 2647 T1934 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 2648 T1934 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2649 T1934 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 2649 T1934 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 2650 T1934 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 2650 T1934 oasc.CoreContainer.<init> New CoreContainer 658674146
[junit4:junit4]   2> 2650 T1934 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 2650 T1934 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 2663 T1934 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 2669 T1934 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:34823/solr
[junit4:junit4]   2> 2670 T1934 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:34823/solr sessionTimeout=3000 watcher=org.apache.solr.common.cloud.ConnectionManager@3d93cd9c
[junit4:junit4]   2> 2670 T1958 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:34823
[junit4:junit4]   2> 2670 T1934 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 2671 T1958 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:34823, initiating session
[junit4:junit4]   2> 2671 T1936 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:57000
[junit4:junit4]   2> 2671 T1936 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:57000
[junit4:junit4]   2> 2672 T1958 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:34823, sessionid = 0x13ab39066f80006, negotiated timeout = 3000
[junit4:junit4]   2> 2672 T1938 oazs.NIOServerCnxn.finishSessionInit Established session 0x13ab39066f80006 with negotiated timeout 3000 for client /127.0.0.1:57000
[junit4:junit4]   2> 2672 T1959 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@3d93cd9c name:ZooKeeperConnection Watcher:127.0.0.1:34823/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 2672 T1934 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 2672 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80006 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2673 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80006 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2674 T1934 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:7004_solr
[junit4:junit4]   2> 2674 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80006 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:7004_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:7004_solr
[junit4:junit4]   2> 2675 T1934 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:7004_solr
[junit4:junit4]   2> 2676 T1950 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 2676 T1956 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 2676 T1953 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 2676 T1945 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 2676 T1934 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 2677 T1934 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 2677 T1934 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 2677 T1934 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 2677 T1934 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 2677 T1934 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 2678 T1934 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 2678 T1934 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 2678 T1934 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 2678 T1934 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 2682 T1934 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 2685 T1934 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 2685 T1934 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 2685 T1934 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 2686 T1934 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 2686 T1934 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 2687 T1934 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 2687 T1934 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 2708 T1934 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 2737 T1934 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 2738 T1934 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 2741 T1934 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 2881 T1946 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2881 T1946 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7003/solr",
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "state":"down",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7003_solr"}
[junit4:junit4]   2> 2883 T1946 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7003/solr",
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "state":"active",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7003_solr"}
[junit4:junit4]   2> 2884 T1956 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 2884 T1953 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 2884 T1950 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 2884 T1945 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 2885 T1959 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 3019 T1934 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 3023 T1934 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 3025 T1934 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 3031 T1934 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 3034 T1934 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 3036 T1934 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 3036 T1934 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 3037 T1934 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_7004/
[junit4:junit4]   2> 3037 T1934 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7fa49941
[junit4:junit4]   2> 3038 T1934 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_7004/index/
[junit4:junit4]   2> 3038 T1934 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_7004/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 3039 T1934 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_7004/index forceNew:false
[junit4:junit4]   2> 3040 T1934 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@3b6739c0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1d9330e7),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 3040 T1934 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 3040 T1934 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 3041 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 3042 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 3042 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 3042 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 3043 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 3043 T1934 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 3043 T1934 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 3044 T1934 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 3044 T1934 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 3044 T1934 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 3045 T1934 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 3045 T1934 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 3045 T1934 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 3045 T1934 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 3046 T1934 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 3046 T1934 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 3046 T1934 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3047 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3047 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3047 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3048 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3048 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3048 T1934 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3049 T1934 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 3049 T1934 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 3051 T1934 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 3053 T1934 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 3053 T1934 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SYNONYMS.TXT, MAPPING-ISOLATIN1ACCENT.TXT, OLD_SYNONYMS.TXT, STOPWORDS.TXT, CURRENCY.XML, SCHEMA.XML, PROTWORDS.TXT, OPEN-EXCHANGE-RATES.JSON]
[junit4:junit4]   2> 3055 T1934 oass.SolrIndexSearcher.<init> Opening Searcher@19a52031 main
[junit4:junit4]   2> 3055 T1934 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.BaseDirectoryWrapper
[junit4:junit4]   2> 3055 T1934 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 3056 T1934 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 3056 T1934 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 3059 T1934 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 3078 T1960 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@19a52031 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 3080 T1934 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 3081 T1934 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 3081 T1934 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:7004/solr shardId:shard1
[junit4:junit4]   2> 3083 T1934 oasc.ZkController.register We are http://127.0.0.1:7004/solr/collection1/ and leader is http://127.0.0.1:7000/solr/collection1/
[junit4:junit4]   2> 3083 T1934 oasc.ZkController.checkRecovery WARNING Skipping recovery according to sys prop solrcloud.skip.autorecovery
[junit4:junit4]   2> 3083 T1934 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 3084 T1934 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3086 T1934 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 3086 T1934 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 3086 T1934 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 3087 T1934 oasc.CoreContainer.<init> New CoreContainer 1440575374
[junit4:junit4]   2> 3087 T1934 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 3087 T1934 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 3107 T1934 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 3113 T1934 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:34823/solr
[junit4:junit4]   2> 3114 T1934 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:34823/solr sessionTimeout=3000 watcher=org.apache.solr.common.cloud.ConnectionManager@f930480
[junit4:junit4]   2> 3114 T1934 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 3114 T1961 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:34823
[junit4:junit4]   2> 3115 T1961 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:34823, initiating session
[junit4:junit4]   2> 3115 T1936 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:57001
[junit4:junit4]   2> 3115 T1936 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:57001
[junit4:junit4]   2> 3116 T1938 oazs.NIOServerCnxn.finishSessionInit Established session 0x13ab39066f80007 with negotiated timeout 3000 for client /127.0.0.1:57001
[junit4:junit4]   2> 3116 T1961 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:34823, sessionid = 0x13ab39066f80007, negotiated timeout = 3000
[junit4:junit4]   2> 3116 T1962 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@f930480 name:ZooKeeperConnection Watcher:127.0.0.1:34823/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 3116 T1934 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 3117 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80007 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3117 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80007 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3118 T1934 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:3333_solr
[junit4:junit4]   2> 3118 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80007 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:3333_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:3333_solr
[junit4:junit4]   2> 3119 T1934 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:3333_solr
[junit4:junit4]   2> 3120 T1956 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4:junit4]   2> 3120 T1953 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4:junit4]   2> 3120 T1959 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4:junit4]   2> 3120 T1945 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4:junit4]   2> 3120 T1950 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4:junit4]   2> 3120 T1934 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 3120 T1934 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 3121 T1934 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 3121 T1934 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 3121 T1934 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 3121 T1934 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 3122 T1934 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 3122 T1934 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 3122 T1934 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 3122 T1934 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 3126 T1934 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 3130 T1934 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 3130 T1934 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 3131 T1934 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 3131 T1934 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 3132 T1934 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 3133 T1934 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 3133 T1934 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 3154 T1934 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 3184 T1934 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 3185 T1934 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 3188 T1934 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 3387 T1946 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3387 T1946 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7004/solr",
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "state":"down",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7004_solr"}
[junit4:junit4]   2> 3389 T1946 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7004/solr",
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "state":"active",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7004_solr"}
[junit4:junit4]   2> 3390 T1959 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 3390 T1945 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 3391 T1953 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 3391 T1962 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 3391 T1950 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 3391 T1956 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 3442 T1934 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 3446 T1934 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 3448 T1934 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 3455 T1934 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 3457 T1934 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 3459 T1934 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 3460 T1934 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 3461 T1934 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_3333/
[junit4:junit4]   2> 3461 T1934 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7fa49941
[junit4:junit4]   2> 3462 T1934 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_3333/index/
[junit4:junit4]   2> 3462 T1934 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_3333/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 3462 T1934 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632316150/data_3333/index forceNew:false
[junit4:junit4]   2> 3463 T1934 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@506176a0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@74f3a369),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 3464 T1934 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 3464 T1934 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 3465 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 3465 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 3466 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 3466 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 3466 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 3467 T1934 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 3467 T1934 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 3467 T1934 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 3467 T1934 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 3468 T1934 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 3468 T1934 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 3468 T1934 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 3469 T1934 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 3469 T1934 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 3469 T1934 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 3470 T1934 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 3470 T1934 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3470 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3471 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3471 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3471 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3471 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3472 T1934 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3472 T1934 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 3472 T1934 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 3474 T1934 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 3476 T1934 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 3476 T1934 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SYNONYMS.TXT, MAPPING-ISOLATIN1ACCENT.TXT, OLD_SYNONYMS.TXT, STOPWORDS.TXT, CURRENCY.XML, SCHEMA.XML, PROTWORDS.TXT, OPEN-EXCHANGE-RATES.JSON]
[junit4:junit4]   2> 3478 T1934 oass.SolrIndexSearcher.<init> Opening Searcher@75755aea main
[junit4:junit4]   2> 3478 T1934 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 3478 T1934 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 3479 T1934 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 3479 T1934 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 3482 T1934 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 3498 T1963 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@75755aea main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 3500 T1934 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 3501 T1934 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 3501 T1934 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:3333/solr shardId:shard2
[junit4:junit4]   2> 3502 T1934 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard2/election
[junit4:junit4]   2> 3504 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80007 type:delete cxid:0x41 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/collections/collection1/leaders/shard2 Error:KeeperErrorCode = NoNode for /solr/collections/collection1/leaders/shard2
[junit4:junit4]   2> 3504 T1934 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 3505 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80007 type:create cxid:0x42 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3893 T1946 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3894 T1946 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:3333/solr",
[junit4:junit4]   2> 	  "shard":"shard2",
[junit4:junit4]   2> 	  "state":"down",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:3333_solr"}
[junit4:junit4]   2> 3896 T1950 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 3897 T1945 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 3897 T1959 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 3897 T1953 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 3896 T1956 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 3896 T1962 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 4006 T1934 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4]   2> 4006 T1934 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 4007 T1934 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:3333/solr/collection1/
[junit4:junit4]   2> 4007 T1934 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard2
[junit4:junit4]   2> 4008 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80007 type:create cxid:0x4c zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4399 T1946 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 4402 T1959 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 4402 T1945 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 4403 T1956 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 4403 T1962 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 4402 T1950 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 4403 T1953 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 4411 T1934 oasc.ZkController.register We are http://127.0.0.1:3333/solr/collection1/ and leader is http://127.0.0.1:3333/solr/collection1/
[junit4:junit4]   2> 4411 T1934 oasc.ZkController.checkRecovery WARNING Skipping recovery according to sys prop solrcloud.skip.autorecovery
[junit4:junit4]   2> 4411 T1934 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 4413 T1934 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 4414 T1934 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:34823/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@4161a6b
[junit4:junit4]   2> 4414 T1964 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:34823
[junit4:junit4]   2> 4414 T1934 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 4415 T1964 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:34823, initiating session
[junit4:junit4]   2> 4415 T1936 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:57002
[junit4:junit4]   2> 4415 T1936 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:57002
[junit4:junit4]   2> 4415 T1938 oazs.NIOServerCnxn.finishSessionInit Established session 0x13ab39066f80008 with negotiated timeout 10000 for client /127.0.0.1:57002
[junit4:junit4]   2> 4416 T1964 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:34823, sessionid = 0x13ab39066f80008, negotiated timeout = 10000
[junit4:junit4]   2> 4416 T1965 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@4161a6b name:ZooKeeperConnection Watcher:127.0.0.1:34823/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 4416 T1934 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 4417 T1934 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 4418 T1934 oasc.LeaderElectionIntegrationTest.setUp ####SETUP_END testSimpleSliceLeaderElection
[junit4:junit4]   2> 4418 T1934 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=723885507
[junit4:junit4]   2> 4419 T1934 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@33d4596c
[junit4:junit4]   2> 4421 T1934 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4:junit4]   2> 4421 T1934 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 4421 T1934 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 4421 T1934 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 4422 T1934 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 4423 T1946 oasc.Overseer$ClusterStateUpdater.amILeader According to ZK I (id=88580575471337474-127.0.0.1:7000_solr-n_0000000000) am no longer a leader.
[junit4:junit4]   2> 4423 T1939 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13ab39066f80002
[junit4:junit4]   2> 4424 T1950 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 4424 T1965 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 4424 T1936 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:56996 which had sessionid 0x13ab39066f80002
[junit4:junit4]   2> 4424 T1959 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 4424 T1956 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 4424 T1953 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 4424 T1962 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 4424 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80003 type:delete cxid:0x49 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer_elect/leader Error:KeeperErrorCode = NoNode for /solr/overseer_elect/leader
[junit4:junit4]   2> 4424 T1934 oaz.ZooKeeper.close Session: 0x13ab39066f80002 closed
[junit4:junit4]   2> 4425 T1950 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4]   2> 4425 T1950 oasc.Overseer.start Overseer (id=88580575471337475-127.0.0.1:7001_solr-n_0000000001) starting
[junit4:junit4]   2> 4426 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80003 type:create cxid:0x4e zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4426 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80003 type:create cxid:0x4f zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4427 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80003 type:create cxid:0x50 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4427 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80003 type:create cxid:0x51 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4427 T1967 oasc.OverseerCollectionProcessor.run Process current queue of collection messages
[junit4:junit4]   2> 4428 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80003 type:delete cxid:0x55 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/collections/collection1/leaders/shard1 Error:KeeperErrorCode = NoNode for /solr/collections/collection1/leaders/shard1
[junit4:junit4]   2> 4428 T1950 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 4428 T1966 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4]   2> 4428 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80003 type:create cxid:0x58 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4429 T1950 oasc.ShardLeaderElectionContext.shouldIBeLeader Checking if I should try and be the leader.
[junit4:junit4]   2> 4429 T1950 oasc.ShardLeaderElectionContext.shouldIBeLeader My last published State was Active, it's okay to be the leader.
[junit4:junit4]   2> 4429 T1966 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 4429 T1950 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 4429 T1950 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:7001/solr/collection1/
[junit4:junit4]   2> 4430 T1966 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:3333/solr",
[junit4:junit4]   2> 	  "shard":"shard2",
[junit4:junit4]   2> 	  "state":"active",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:3333_solr"}
[junit4:junit4]   2> 4430 T1950 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4:junit4]   2> 4431 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80003 type:create cxid:0x6b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4434 T1953 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 4434 T1965 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 4434 T1950 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 4434 T1956 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 4434 T1959 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 4437 T1962 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 4925 T1934 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=873488085
[junit4:junit4]   2> 4925 T1934 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@2abaa354
[junit4:junit4]   2> 4930 T1934 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4:junit4]   2> 4931 T1934 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 4931 T1934 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 4932 T1934 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 4932 T1934 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 4934 T1966 oasc.Overseer$ClusterStateUpdater.amILeader According to ZK I (id=88580575471337475-127.0.0.1:7001_solr-n_0000000001) am no longer a leader.
[junit4:junit4]   2> 4934 T1939 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13ab39066f80003
[junit4:junit4]   2> 4936 T1950 oascc.ZkStateReader$3.process WARNING ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4:junit4]   2> 4937 T1936 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:56997 which had sessionid 0x13ab39066f80003
[junit4:junit4]   2> 4937 T1959 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4]   2> 4936 T1934 oaz.ZooKeeper.close Session: 0x13ab39066f80003 closed
[junit4:junit4]   2> 4936 T1962 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4]   2> 4942 T1965 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4]   2> 4941 T1956 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4]   2> 4941 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80004 type:delete cxid:0x49 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer_elect/leader Error:KeeperErrorCode = NoNode for /solr/overseer_elect/leader
[junit4:junit4]   2> 4941 T1950 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 4943 T1953 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4]   2> 4944 T1953 oasc.Overseer.start Overseer (id=88580575471337476-127.0.0.1:7002_solr-n_0000000002) starting
[junit4:junit4]   2> 4944 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80004 type:create cxid:0x4e zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4945 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80004 type:create cxid:0x4f zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4946 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80004 type:create cxid:0x50 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4947 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80004 type:create cxid:0x51 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4947 T1969 oasc.OverseerCollectionProcessor.run Process current queue of collection messages
[junit4:junit4]   2> 4948 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80004 type:delete cxid:0x54 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/collections/collection1/leaders/shard1 Error:KeeperErrorCode = NoNode for /solr/collections/collection1/leaders/shard1
[junit4:junit4]   2> 4948 T1953 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 4949 T1968 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4]   2> 4949 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80004 type:create cxid:0x58 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4951 T1953 oasc.ShardLeaderElectionContext.shouldIBeLeader Checking if I should try and be the leader.
[junit4:junit4]   2> 4951 T1953 oasc.ShardLeaderElectionContext.shouldIBeLeader My last published State was Active, it's okay to be the leader.
[junit4:junit4]   2> 4951 T1968 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 4951 T1953 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 4952 T1953 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:7002/solr/collection1/
[junit4:junit4]   2> 4952 T1953 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4:junit4]   2> 4957 T1962 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 4957 T1959 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 4957 T1965 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 4957 T1956 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 4959 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80004 type:create cxid:0x6d zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4960 T1953 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4]   2> 4961 T1953 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 5424 T1945 oascc.ZkStateReader$3.process WARNING ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4:junit4]   2> 5424 T1945 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 5462 T1968 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 5465 T1956 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 5465 T1959 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 5465 T1953 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 5465 T1962 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 5465 T1965 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 5492 T1934 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1238867524
[junit4:junit4]   2> 5492 T1934 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@6b4f5277
[junit4:junit4]   2> 5496 T1934 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4:junit4]   2> 5497 T1934 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 5497 T1934 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 5498 T1934 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 5498 T1934 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 5499 T1968 oasc.Overseer$ClusterStateUpdater.amILeader According to ZK I (id=88580575471337476-127.0.0.1:7002_solr-n_0000000002) am no longer a leader.
[junit4:junit4]   2> 5499 T1939 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13ab39066f80004
[junit4:junit4]   2> 5501 T1965 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4]   2> 5501 T1934 oaz.ZooKeeper.close Session: 0x13ab39066f80004 closed
[junit4:junit4]   2> 5501 T1962 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4]   2> 5501 T1936 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:56998 which had sessionid 0x13ab39066f80004
[junit4:junit4]   2> 5501 T1959 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4]   2> 5502 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80005 type:delete cxid:0x4a zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/collections/collection1/leaders/shard1 Error:KeeperErrorCode = NoNode for /solr/collections/collection1/leaders/shard1
[junit4:junit4]   2> 5502 T1956 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 5503 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80005 type:create cxid:0x4b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5504 T1956 oasc.ShardLeaderElectionContext.shouldIBeLeader Checking if I should try and be the leader.
[junit4:junit4]   2> 5504 T1956 oasc.ShardLeaderElectionContext.shouldIBeLeader My last published State was Active, it's okay to be the leader.
[junit4:junit4]   2> 5504 T1956 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 5505 T1956 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:7003/solr/collection1/
[junit4:junit4]   2> 5505 T1956 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4:junit4]   2> 5508 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80005 type:create cxid:0x53 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5510 T1956 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4]   2> 5510 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80005 type:delete cxid:0x57 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer_elect/leader Error:KeeperErrorCode = NoNode for /solr/overseer_elect/leader
[junit4:junit4]   2> 5511 T1956 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4]   2> 5512 T1956 oasc.Overseer.start Overseer (id=88580575471337477-127.0.0.1:7003_solr-n_0000000003) starting
[junit4:junit4]   2> 5513 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80005 type:create cxid:0x5c zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5513 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80005 type:create cxid:0x5d zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5514 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80005 type:create cxid:0x5e zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5515 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80005 type:create cxid:0x5f zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5516 T1971 oasc.OverseerCollectionProcessor.run Process current queue of collection messages
[junit4:junit4]   2> 5516 T1970 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4]   2> 5517 T1970 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 5522 T1959 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 5522 T1962 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 5522 T1965 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 5522 T1956 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 6001 T1934 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=2107628482
[junit4:junit4]   2> 6002 T1934 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@34fc5a2c
[junit4:junit4]   2> 6005 T1934 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4:junit4]   2> 6005 T1934 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 6006 T1934 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 6006 T1934 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 6006 T1934 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 6007 T1970 oasc.Overseer$ClusterStateUpdater.amILeader According to ZK I (id=88580575471337477-127.0.0.1:7003_solr-n_0000000003) am no longer a leader.
[junit4:junit4]   2> 6007 T1939 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13ab39066f80005
[junit4:junit4]   2> 6008 T1965 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4:junit4]   2> 6008 T1936 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:56999 which had sessionid 0x13ab39066f80005
[junit4:junit4]   2> 6008 T1934 oaz.ZooKeeper.close Session: 0x13ab39066f80005 closed
[junit4:junit4]   2> 6008 T1959 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4:junit4]   2> 6008 T1962 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4:junit4]   2> 6010 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80006 type:delete cxid:0x4b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer_elect/leader Error:KeeperErrorCode = NoNode for /solr/overseer_elect/leader
[junit4:junit4]   2> 6010 T1959 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4]   2> 6011 T1959 oasc.Overseer.start Overseer (id=88580575471337478-127.0.0.1:7004_solr-n_0000000004) starting
[junit4:junit4]   2> 6011 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80006 type:create cxid:0x50 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 6012 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80006 type:create cxid:0x51 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 6012 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80006 type:create cxid:0x52 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 6013 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80006 type:create cxid:0x53 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 6014 T1973 oasc.OverseerCollectionProcessor.run Process current queue of collection messages
[junit4:junit4]   2> 6014 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80006 type:delete cxid:0x57 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/collections/collection1/leaders/shard1 Error:KeeperErrorCode = NoNode for /solr/collections/collection1/leaders/shard1
[junit4:junit4]   2> 6014 T1972 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4]   2> 6014 T1959 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 6015 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80006 type:create cxid:0x5b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 6015 T1959 oasc.ShardLeaderElectionContext.shouldIBeLeader Checking if I should try and be the leader.
[junit4:junit4]   2> 6015 T1959 oasc.ShardLeaderElectionContext.shouldIBeLeader My last published State was Active, it's okay to be the leader.
[junit4:junit4]   2> 6016 T1959 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 6016 T1959 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:7004/solr/collection1/
[junit4:junit4]   2> 6016 T1959 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4:junit4]   2> 6017 T1939 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39066f80006 type:create cxid:0x65 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 6501 T1953 oascc.ZkStateReader$3.process WARNING ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4:junit4]   2> 6501 T1953 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 6516 T1972 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 6521 T1959 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (2)
[junit4:junit4]   2> 6521 T1962 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (2)
[junit4:junit4]   2> 6521 T1965 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (2)
[junit4:junit4]   2> 7008 T1956 oascc.ZkStateReader$3.process WARNING ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4:junit4]   2> 7008 T1956 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 7009 T1939 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13ab39066f80008
[junit4:junit4]   2> 7012 T1965 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 7013 T1936 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:57002 which had sessionid 0x13ab39066f80008
[junit4:junit4]   2> 7012 T1934 oaz.ZooKeeper.close Session: 0x13ab39066f80008 closed
[junit4:junit4]   2> 7013 T1934 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1440575374
[junit4:junit4]   2> 7013 T1934 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@214d2794
[junit4:junit4]   2> 7018 T1934 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4:junit4]   2> 7018 T1934 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 7019 T1934 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 7019 T1934 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 7019 T1934 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 7020 T1939 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13ab39066f80007
[junit4:junit4]   2> 7022 T1934 oaz.ZooKeeper.close Session: 0x13ab39066f80007 closed
[junit4:junit4]   2> 7022 T1959 oascc.ZkStateReader$3.process Updating live nodes... (1)
[junit4:junit4]   2> 7023 T1934 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=658674146
[junit4:junit4]   2> 7022 T1936 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:57001 which had sessionid 0x13ab39066f80007
[junit4:junit4]   2> 7023 T1934 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@2ff016c6
[junit4:junit4]   2> 7023 T1934 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4:junit4]   2> 7024 T1934 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 7024 T1934 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 7024 T1934 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 7024 T1934 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 7025 T1972 oasc.Overseer$ClusterStateUpdater.amILeader According to ZK I (id=88580575471337478-127.0.0.1:7004_solr-n_0000000004) am no longer a leader.
[junit4:junit4]   2> 7025 T1939 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13ab39066f80006
[junit4:junit4]   2> 7032 T1959 oascc.ZkStateReader$3.process WARNING ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4:junit4]   2> 7032 T1934 oaz.ZooKeeper.close Session: 0x13ab39066f80006 closed
[junit4:junit4]   2> 7032 T1936 oazs.NIOServerCnxn.doIO WARNING EndOfStreamException: Unable to read additional data from client sessionid 0x13ab39066f80006, likely client has closed socket
[junit4:junit4]   2> 7033 T1939 oazs.PrepRequestProcessor.run PrepRequestProcessor exited loop!
[junit4:junit4]   2> 7033 T1938 oazs.SyncRequestProcessor.run SyncRequestProcessor exited!
[junit4:junit4]   2> 7032 T1959 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 7033 T1936 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:57000 which had sessionid 0x13ab39066f80006
[junit4:junit4]   2> 7034 T1934 oazs.FinalRequestProcessor.shutdown shutdown of request processor complete
[junit4:junit4]   2> 7036 T1936 oazs.NIOServerCnxn$Factory.run NIOServerCnxn factory exited run method
[junit4:junit4]   2> 7036 T1934 oazs.FinalRequestProcessor.shutdown shutdown of request processor complete
[junit4:junit4]   2> 7037 T1934 oas.SolrTestCaseJ4.tearDown ###Ending testSimpleSliceLeaderElection
[junit4:junit4]   2> 7053 T1934 oas.SolrTestCaseJ4.setUp ###Starting testLeaderElectionAfterClientTimeout
[junit4:junit4]   2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632323202
[junit4:junit4]   2> 7054 T1934 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4]   2> 7055 T1974 oazs.ZooKeeperServer.setTickTime tickTime set to 1000
[junit4:junit4]   2> 7055 T1974 oazs.NIOServerCnxn$Factory.<init> binding to port 0.0.0.0/0.0.0.0:0
[junit4:junit4]   2> 7056 T1974 oazsp.FileTxnSnapLog.save Snapshotting: 0
[junit4:junit4]   2> 7154 T1934 oasc.ZkTestServer.run start zk server on port:34367
[junit4:junit4]   2> 7155 T1934 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:34367 sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@48177f47
[junit4:junit4]   2> 7155 T1979 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:34367
[junit4:junit4]   2> 7155 T1934 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 7156 T1979 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:34367, initiating session
[junit4:junit4]   2> 7156 T1975 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:57574
[junit4:junit4]   2> 7156 T1975 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:57574
[junit4:junit4]   2> 7156 T1977 oazsp.FileTxnLog.append Creating new log file: log.1
[junit4:junit4]   2> 7402 T1977 oazs.NIOServerCnxn.finishSessionInit Established session 0x13ab39082840000 with negotiated timeout 10000 for client /127.0.0.1:57574
[junit4:junit4]   2> 7403 T1979 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:34367, sessionid = 0x13ab39082840000, negotiated timeout = 10000
[junit4:junit4]   2> 7403 T1980 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@48177f47 name:ZooKeeperConnection Watcher:127.0.0.1:34367 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 7404 T1934 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 7404 T1934 oascc.SolrZkClient.makePath makePath: /solr
[junit4:junit4]   2> 7407 T1978 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13ab39082840000
[junit4:junit4]   2> 7408 T1980 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 7408 T1934 oaz.ZooKeeper.close Session: 0x13ab39082840000 closed
[junit4:junit4]   2> 7409 T1975 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:57574 which had sessionid 0x13ab39082840000
[junit4:junit4]   2> 7409 T1934 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:34367/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@705073df
[junit4:junit4]   2> 7410 T1981 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:34367
[junit4:junit4]   2> 7410 T1934 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 7411 T1981 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:34367, initiating session
[junit4:junit4]   2> 7411 T1975 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:57575
[junit4:junit4]   2> 7411 T1975 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:57575
[junit4:junit4]   2> 7414 T1977 oazs.NIOServerCnxn.finishSessionInit Established session 0x13ab39082840001 with negotiated timeout 10000 for client /127.0.0.1:57575
[junit4:junit4]   2> 7414 T1981 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:34367, sessionid = 0x13ab39082840001, negotiated timeout = 10000
[junit4:junit4]   2> 7415 T1982 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@705073df name:ZooKeeperConnection Watcher:127.0.0.1:34367/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 7417 T1934 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 7418 T1934 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4:junit4]   2> 7421 T1934 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4:junit4]   2> 7423 T1934 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4:junit4]   2> 7433 T1934 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4:junit4]   2> 7435 T1934 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 7436 T1934 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 7612 T1934 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4:junit4]   2> 7613 T1934 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4:junit4]   2> 7802 T1934 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 7803 T1934 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 7805 T1934 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4:junit4]   2> 7807 T1934 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
[junit4:junit4]   2> 7810 T1934 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4:junit4]   2> 7811 T1934 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
[junit4:junit4]   2> 7814 T1934 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4:junit4]   2> 7815 T1934 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
[junit4:junit4]   2> 7818 T1934 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 7818 T1934 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 7821 T1934 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 7822 T1934 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 7824 T1934 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 7825 T1934 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 7827 T1934 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4:junit4]   2> 7828 T1934 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
[junit4:junit4]   2> 7831 T1978 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13ab39082840001
[junit4:junit4]   2> 7832 T1982 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 7832 T1975 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:57575 which had sessionid 0x13ab39082840001
[junit4:junit4]   2> 7832 T1934 oaz.ZooKeeper.close Session: 0x13ab39082840001 closed
[junit4:junit4]   2> 7833 T1934 oasc.LeaderElectionIntegrationTest.setUp ####SETUP_START testLeaderElectionAfterClientTimeout
[junit4:junit4]   2> 7835 T1934 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 7835 T1934 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 7836 T1934 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 7837 T1934 oasc.CoreContainer.<init> New CoreContainer 1565308011
[junit4:junit4]   2> 7837 T1934 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 7838 T1934 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 7853 T1937 oazs.SessionTrackerImpl.run SessionTrackerImpl exited loop!
[junit4:junit4]   2> 7870 T1934 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 7876 T1934 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:34367/solr
[junit4:junit4]   2> 7877 T1934 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:34367/solr sessionTimeout=3000 watcher=org.apache.solr.common.cloud.ConnectionManager@723c241
[junit4:junit4]   2> 7877 T1983 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:34367
[junit4:junit4]   2> 7877 T1934 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 7878 T1983 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:34367, initiating session
[junit4:junit4]   2> 7878 T1975 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:57577
[junit4:junit4]   2> 7878 T1975 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:57577
[junit4:junit4]   2> 7879 T1977 oazs.NIOServerCnxn.finishSessionInit Established session 0x13ab39082840002 with negotiated timeout 3000 for client /127.0.0.1:57577
[junit4:junit4]   2> 7879 T1983 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:34367, sessionid = 0x13ab39082840002, negotiated timeout = 3000
[junit4:junit4]   2> 7879 T1984 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@723c241 name:ZooKeeperConnection Watcher:127.0.0.1:34367/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 7879 T1934 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 7880 T1978 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39082840002 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 7882 T1934 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4:junit4]   2> 7883 T1934 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:7000_solr
[junit4:junit4]   2> 7884 T1978 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39082840002 type:delete cxid:0x7 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:7000_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:7000_solr
[junit4:junit4]   2> 7884 T1934 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:7000_solr
[junit4:junit4]   2> 7886 T1934 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 7887 T1934 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 7887 T1934 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 7887 T1934 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 7888 T1934 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 7888 T1934 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 7888 T1934 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 7889 T1934 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 7889 T1934 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 7889 T1934 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 7892 T1934 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4:junit4]   2> 7894 T1978 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39082840002 type:delete cxid:0x15 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer_elect/leader Error:KeeperErrorCode = NoNode for /solr/overseer_elect/leader
[junit4:junit4]   2> 7894 T1934 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4]   2> 7895 T1934 oasc.Overseer.start Overseer (id=88580575933497346-127.0.0.1:7000_solr-n_0000000000) starting
[junit4:junit4]   2> 7895 T1978 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39082840002 type:create cxid:0x1a zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 7896 T1978 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39082840002 type:create cxid:0x1b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 7896 T1978 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39082840002 type:create cxid:0x1c zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 7897 T1978 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39082840002 type:create cxid:0x1d zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 7897 T1934 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4:junit4]   2> 7897 T1986 oasc.OverseerCollectionProcessor.run Process current queue of collection messages
[junit4:junit4]   2> 7898 T1934 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 7900 T1985 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4]   2> 7902 T1934 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 7902 T1934 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 7903 T1934 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 7903 T1934 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 7904 T1934 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 7905 T1934 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 7905 T1934 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 7931 T1934 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 7981 T1934 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 7982 T1934 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 7987 T1934 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 8022 T1962 oascc.ZkStateReader$3.process WARNING ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4:junit4]   2> 8022 T1962 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 8276 T1934 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 8281 T1934 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 8283 T1934 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 8288 T1934 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 8291 T1934 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 8295 T1934 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 8296 T1934 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 8296 T1934 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632323202/data_7000/
[junit4:junit4]   2> 8297 T1934 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7fa49941
[junit4:junit4]   2> 8298 T1934 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632323202/data_7000/index/
[junit4:junit4]   2> 8298 T1934 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632323202/data_7000/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 8299 T1934 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-LeaderElectionIntegrationTest-1351632323202/data_7000/index forceNew:false
[junit4:junit4]   2> 8301 T1934 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@33eb357f lockFactory=org.apache.lucene.store.NativeFSLockFactory@598a6e64),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 8301 T1934 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 8302 T1934 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 8303 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 8304 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 8304 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 8305 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 8305 T1934 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 8306 T1934 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 8306 T1934 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 8307 T1934 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 8307 T1934 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 8308 T1934 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 8308 T1934 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 8308 T1934 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 8309 T1934 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 8309 T1934 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 8310 T1934 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 8310 T1934 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 8311 T1934 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 8311 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 8312 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 8312 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 8312 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 8313 T1934 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 8313 T1934 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 8314 T1934 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 8314 T1934 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 8318 T1934 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 8320 T1934 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 8321 T1934 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SYNONYMS.TXT, MAPPING-ISOLATIN1ACCENT.TXT, OLD_SYNONYMS.TXT, STOPWORDS.TXT, CURRENCY.XML, SCHEMA.XML, PROTWORDS.TXT, OPEN-EXCHANGE-RATES.JSON]
[junit4:junit4]   2> 8323 T1934 oass.SolrIndexSearcher.<init> Opening Searcher@1251ce05 main
[junit4:junit4]   2> 8324 T1934 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 8324 T1934 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 8324 T1934 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 8325 T1934 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 8330 T1934 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 8348 T1987 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1251ce05 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 8350 T1934 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 8351 T1978 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39082840002 type:create cxid:0x50 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer/queue Error:KeeperErrorCode = NoNode for /solr/overseer/queue
[junit4:junit4]   2> 8352 T1934 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 8352 T1934 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:7000/solr shardId:shard1
[junit4:junit4]   2> 8352 T1934 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election
[junit4:junit4]   2> 8354 T1978 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39082840002 type:delete cxid:0x5f zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/collections/collection1/leaders Error:KeeperErrorCode = NoNode for /solr/collections/collection1/leaders
[junit4:junit4]   2> 8355 T1934 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 8355 T1978 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39082840002 type:create cxid:0x60 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 8401 T1985 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 8401 T1985 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7000/solr",
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "state":"down",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7000_solr"}
[junit4:junit4]   2> 8402 T1978 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39082840002 type:create cxid:0x67 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer/queue-work Error:KeeperErrorCode = NoNode for /solr/overseer/queue-work
[junit4:junit4]   2> 8405 T1984 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (1)
[junit4:junit4]   2> 8856 T1934 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4]   2> 8857 T1934 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 8857 T1934 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:7000/solr/collection1/
[junit4:junit4]   2> 8858 T1934 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4:junit4]   2> 8860 T1978 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39082840002 type:create cxid:0x85 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 8908 T1985 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 10912 T1983 oaz.ClientCnxn$SendThread.run Client session timed out, have not heard from server in 2002ms for sessionid 0x13ab39082840002, closing socket connection and attempting reconnect
[junit4:junit4]   2> 10912 T1975 oazs.NIOServerCnxn.doIO WARNING EndOfStreamException: Unable to read additional data from client sessionid 0x13ab39082840002, likely client has closed socket
[junit4:junit4]   2> 10913 T1975 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:57577 which had sessionid 0x13ab39082840002
[junit4:junit4]   2> 11013 T1984 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@723c241 name:ZooKeeperConnection Watcher:127.0.0.1:34367/solr got event WatchedEvent state:Disconnected type:None path:null path:null type:None
[junit4:junit4]   2> 11013 T1984 oascc.ConnectionManager.process zkClient has disconnected
[junit4:junit4]   2> 11631 T1977 oazsp.FileTxnLog.commit WARNING fsync-ing the write ahead log in SyncThread:0 took 2720ms which will adversely effect operation latency. See the ZooKeeper troubleshooting guide
[junit4:junit4]   2> 11632 T1977 oazs.NIOServerCnxn.sendBuffer SEVERE Unexpected Exception:  java.nio.channels.CancelledKeyException
[junit4:junit4]   2> 	at sun.nio.ch.SelectionKeyImpl.ensureValid(SelectionKeyImpl.java:73)
[junit4:junit4]   2> 	at sun.nio.ch.SelectionKeyImpl.interestOps(SelectionKeyImpl.java:77)
[junit4:junit4]   2> 	at org.apache.zookeeper.server.NIOServerCnxn.sendBuffer(NIOServerCnxn.java:418)
[junit4:junit4]   2> 	at org.apache.zookeeper.server.NIOServerCnxn.sendResponse(NIOServerCnxn.java:1509)
[junit4:junit4]   2> 	at org.apache.zookeeper.server.FinalRequestProcessor.processRequest(FinalRequestProcessor.java:359)
[junit4:junit4]   2> 	at org.apache.zookeeper.server.SyncRequestProcessor.flush(SyncRequestProcessor.java:163)
[junit4:junit4]   2> 	at org.apache.zookeeper.server.SyncRequestProcessor.run(SyncRequestProcessor.java:98)
[junit4:junit4]   2> 
[junit4:junit4]   2> 11632 T1977 oazs.NIOServerCnxn.sendBuffer SEVERE Unexpected Exception:  java.nio.channels.CancelledKeyException
[junit4:junit4]   2> 	at sun.nio.ch.SelectionKeyImpl.ensureValid(SelectionKeyImpl.java:73)
[junit4:junit4]   2> 	at sun.nio.ch.SelectionKeyImpl.interestOps(SelectionKeyImpl.java:77)
[junit4:junit4]   2> 	at org.apache.zookeeper.server.NIOServerCnxn.sendBuffer(NIOServerCnxn.java:418)
[junit4:junit4]   2> 	at org.apache.zookeeper.server.NIOServerCnxn.sendResponse(NIOServerCnxn.java:1509)
[junit4:junit4]   2> 	at org.apache.zookeeper.server.FinalRequestProcessor.processRequest(FinalRequestProcessor.java:162)
[junit4:junit4]   2> 	at org.apache.zookeeper.server.SyncRequestProcessor.run(SyncRequestProcessor.java:135)
[junit4:junit4]   2> 
[junit4:junit4]   2> 12201 T1983 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost.localdomain/127.0.0.1:34367
[junit4:junit4]   2> 12202 T1975 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:57580
[junit4:junit4]   2> 12202 T1983 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:34367, initiating session
[junit4:junit4]   2> 12209 T1975 oazs.NIOServerCnxn.readConnectRequest Client attempting to renew session 0x13ab39082840002 at /127.0.0.1:57580
[junit4:junit4]   2> 12209 T1975 oazs.NIOServerCnxn.finishSessionInit Established session 0x13ab39082840002 with negotiated timeout 3000 for client /127.0.0.1:57580
[junit4:junit4]   2> 12209 T1983 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:34367, sessionid = 0x13ab39082840002, negotiated timeout = 3000
[junit4:junit4]   2> 12210 T1978 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ab39082840002 type:delete cxid:0x91 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer/queue/qn-0000000004 Error:KeeperErrorCode = NoNode for /solr/overseer/queue/qn-0000000004
[junit4:junit4]   2> 12210 T1984 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@723c241 name:ZooKeeperConnection Watcher:127.0.0.1:34367/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 12216 T1985 ccr.RandomizedRunner$QueueUncaughtExceptionsHandler.uncaughtException WARNING Uncaught exception in thread: Thread[Thread-821,5,Overseer state updater.] java.util.NoSuchElementException
[junit4:junit4]   2> 	at __randomizedtesting.SeedInfo.seed([5E015ADAF27D27F0]:0)
[junit4:junit4]   2> 	at org.apache.solr.cloud.DistributedQueue.remove(DistributedQueue.java:148)
[junit4:junit4]   2> 	at org.apache.solr.cloud.Overseer$ClusterStateUpdater.run(Overseer.java:131)
[junit4:junit4]   2> 	at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 
[junit4:junit4]   2> 38879 T1934 oasc.ZkController.getLeader SEVERE Error getting leader from zk org.apache.solr.common.SolrException: No registered leader was found, collection:collection1 slice:shard1
[junit4:junit4]   2> 	at org.apache.solr.common.cloud.ZkStateReader.getLeaderProps(ZkStateReader.java:413)
[junit4:junit4]   2> 	at org.apache.solr.common.cloud.ZkStateReader.getLeaderUrl(ZkStateReader.java:390)
[junit4:junit4]   2> 	at org.apache.solr.cloud.ZkController.getLeader(ZkController.java:642)
[junit4:junit4]   2> 	at org.apache.solr.cloud.ZkController.register(ZkController.java:577)
[junit4:junit4]   2> 	at org.apache.solr.cloud.ZkController.register(ZkController.java:532)
[junit4:junit4]   2> 	at org.apache.solr.core.CoreContainer.registerInZk(CoreContainer.java:708)
[junit4:junit4]   2> 	at org.apache.solr.core.CoreContainer.register(CoreContainer.java:692)
[junit4:junit4]   2> 	at org.apache.solr.core.CoreContainer.load(CoreContainer.java:531)
[junit4:junit4]   2> 	at org.apache.solr.core.CoreContainer.load(CoreContainer.java:351)
[junit4:junit4]   2> 	at org.apache.solr.core.CoreContainer$Initializer.initialize(CoreContainer.java:303)
[junit4:junit4]   2> 	at org.apache.solr.cloud.LeaderElectionIntegrationTest.setupContainer(LeaderElectionIntegrationTest.java:152)
[junit4:junit4]   2> 	at org.apache.solr.cloud.LeaderElectionIntegrationTest.setUp(LeaderElectionIntegrationTest.java:100)
[junit4:junit4]   2> 	at sun.reflect.GeneratedMethodAccessor7.invoke(Unknown Source)
[junit4:junit4]   2> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4:junit4]   2> 	at java.lang.reflect.Method.invoke(Method.java:474)
[junit4:junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:771)
[junit4:junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]   2> 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4]   2> 	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4]   2> 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]   2> 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4:junit4]   2> 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]   2> 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4:junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4:junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4:junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4:junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4:junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4:junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]   2> 	

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

ne.index.SegmentInfos.read(SegmentInfos.java:285)
[junit4:junit4]   1> 	at org.apache.lucene.index.SegmentInfos$1.doBody(SegmentInfos.java:347)
[junit4:junit4]   1> 	at org.apache.lucene.index.SegmentInfos$FindSegmentsFile.run(SegmentInfos.java:783)
[junit4:junit4]   1> 	at org.apache.lucene.index.SegmentInfos$FindSegmentsFile.run(SegmentInfos.java:630)
[junit4:junit4]   1> 	at org.apache.lucene.index.SegmentInfos.read(SegmentInfos.java:350)
[junit4:junit4]   1> 	at org.apache.lucene.index.CheckIndex.checkIndex(CheckIndex.java:383)
[junit4:junit4]   1> 	at org.apache.lucene.util._TestUtil.checkIndex(_TestUtil.java:199)
[junit4:junit4]   1> 	at org.apache.lucene.store.MockDirectoryWrapper.close(MockDirectoryWrapper.java:605)
[junit4:junit4]   1> 	at org.apache.solr.core.CachingDirectoryFactory.close(CachingDirectoryFactory.java:124)
[junit4:junit4]   1> 	at org.apache.solr.core.SolrCore.close(SolrCore.java:954)
[junit4:junit4]   1> 	at org.apache.solr.core.CoreContainer.load(CoreContainer.java:539)
[junit4:junit4]   1> 	at org.apache.solr.core.CoreContainer.load(CoreContainer.java:351)
[junit4:junit4]   1> 	at org.apache.solr.core.CoreContainer$Initializer.initialize(CoreContainer.java:303)
[junit4:junit4]   1> 	at org.apache.solr.cloud.LeaderElectionIntegrationTest.setupContainer(LeaderElectionIntegrationTest.java:152)
[junit4:junit4]   1> 	at org.apache.solr.cloud.LeaderElectionIntegrationTest.setUp(LeaderElectionIntegrationTest.java:107)
[junit4:junit4]   1> 	at sun.reflect.GeneratedMethodAccessor7.invoke(Unknown Source)
[junit4:junit4]   1> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4:junit4]   1> 	at java.lang.reflect.Method.invoke(Method.java:474)
[junit4:junit4]   1> 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4]   1> 	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4]   1> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:771)
[junit4:junit4]   1> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4]   1> 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]   1> 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4]   1> 	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4]   1> 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]   1> 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]   1> 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4:junit4]   1> 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]   1> 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]   1> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]   1> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]   1> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4:junit4]   1> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4:junit4]   1> 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4:junit4]   1> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4:junit4]   1> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4:junit4]   1> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4:junit4]   1> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]   1> 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]   1> 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]   1> 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4:junit4]   1> 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]   1> 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]   1> 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]   1> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]   1> 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4:junit4]   1> 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]   1> 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]   1> 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4:junit4]   1> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]   1> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]   1> 	at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   1> 
[junit4:junit4]   2> NOTE: test params are: codec=Lucene41: {}, sim=RandomSimilarityProvider(queryNorm=true,coord=no): {}, locale=ar_SY, timezone=AST
[junit4:junit4]   2> NOTE: Linux 3.2.0-32-generic amd64/Oracle Corporation 1.8.0-ea (64-bit)/cpus=8,threads=3,free=64626976,total=333119488
[junit4:junit4]   2> NOTE: All tests run in this JVM: [SolrCoreTest, SolrIndexConfigTest, AnalysisAfterCoreReloadTest, ZkNodePropsTest, StatelessScriptUpdateProcessorFactoryTest, TestCollationKeyRangeQueries, FileUtilsTest, HighlighterTest, TestPluginEnable, PolyFieldTest, TestAnalyzedSuggestions, SuggesterTest, PingRequestHandlerTest, TestRealTimeGet, ZkSolrClientTest, TermVectorComponentDistributedTest, PrimUtilsTest, FieldMutatingUpdateProcessorTest, MultiTermTest, ScriptEngineTest, TestStressVersions, DistributedQueryElevationComponentTest, TestSolrDeletionPolicy2, TestBM25SimilarityFactory, TermVectorComponentTest, TestQueryUtils, DocumentBuilderTest, URLClassifyProcessorTest, DisMaxRequestHandlerTest, SolrInfoMBeanTest, IndexSchemaTest, TestCSVLoader, TestSolrCoreProperties, ConvertedLegacyTest, ClusterStateTest, TestOmitPositions, DirectUpdateHandlerTest, SoftAutoCommitTest, BasicDistributedZk2Test, RequiredFieldsTest, StandardRequestHandlerTest, TestFoldingMultitermQuery, OpenExchangeRatesOrgProviderTest, TestMultiCoreConfBootstrap, TestReversedWildcardFilterFactory, ReturnFieldsTest, ClusterStateUpdateTest, DebugComponentTest, TestFastOutputStream, TestCharFilters, TestDistributedSearch, BasicFunctionalityTest, SuggesterTSTTest, TestSort, OverseerTest, RecoveryZkTest, FullSolrCloudDistribCmdsTest, TestReplicationHandler, LeaderElectionIntegrationTest]
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=LeaderElectionIntegrationTest -Dtests.seed=5E015ADAF27D27F0 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ar_SY -Dtests.timezone=AST -Dtests.file.encoding=UTF-8
[junit4:junit4] ERROR   0.00s J1 | LeaderElectionIntegrationTest (suite) <<<
[junit4:junit4]    > Throwable #1: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([5E015ADAF27D27F0]:0)
[junit4:junit4]    > Throwable #2: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=1985, name=Thread-821, state=RUNNABLE, group=Overseer state updater.]
[junit4:junit4]    > Caused by: java.util.NoSuchElementException
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([5E015ADAF27D27F0]:0)
[junit4:junit4]    > 	at org.apache.solr.cloud.DistributedQueue.remove(DistributedQueue.java:148)
[junit4:junit4]    > 	at org.apache.solr.cloud.Overseer$ClusterStateUpdater.run(Overseer.java:131)
[junit4:junit4]    > 	at java.lang.Thread.run(Thread.java:722)
[junit4:junit4] Completed on J1 in 7222.86s, 2 tests, 3 errors <<< FAILURES!

[...truncated 11 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:335: 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/solr/build.xml:178: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/module-build.xml:61: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1159: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:827: There were test failures: 233 suites, 965 tests, 2 suite-level errors, 1 error, 8 ignored (3 assumptions)

Total time: 138 minutes 54 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Description set: Java: 64bit/jdk1.8.0-ea-b58 -XX:+UseParallelGC
Email was triggered for: Failure
Sending email for trigger: Failure



Mime
View raw message