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 # 1680 - Failure!
Date Thu, 11 Oct 2012 11:43:16 GMT
Build: http://jenkins.sd-datasolutions.de/job/Lucene-Solr-4.x-Linux/1680/
Java: 64bit/jdk1.8.0-ea-b58 -XX:+UseParallelGC

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

Error Message:
Server at http://127.0.0.1:59957/solr/collection1 returned non ok status:404, message:Can not find: /solr/collection1/select

Stack Trace:
org.apache.solr.common.SolrException: Server at http://127.0.0.1:59957/solr/collection1 returned non ok status:404, message:Can not find: /solr/collection1/select
	at __randomizedtesting.SeedInfo.seed([7A54949A9D476414:FBB21A82EA180428]:0)
	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:374)
	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:181)
	at org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:90)
	at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:301)
	at org.apache.solr.cloud.RecoveryZkTest.doTest(RecoveryZkTest.java:92)
	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:695)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:474)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
	at java.lang.Thread.run(Thread.java:722)




Build Log:
[...truncated 8642 lines...]
[junit4:junit4] Suite: org.apache.solr.cloud.RecoveryZkTest
[junit4:junit4]   2> 2 T960 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4:junit4]   2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-RecoveryZkTest-1349955598084
[junit4:junit4]   2> 3 T960 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4]   2> 5 T961 oazs.ZooKeeperServer.setTickTime tickTime set to 1000
[junit4:junit4]   2> 5 T961 oazs.NIOServerCnxn$Factory.<init> binding to port 0.0.0.0/0.0.0.0:0
[junit4:junit4]   2> 7 T961 oazsp.FileTxnSnapLog.save Snapshotting: 0
[junit4:junit4]   2> 104 T960 oasc.ZkTestServer.run start zk server on port:47481
[junit4:junit4]   2> 105 T960 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47481 sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@204a71e6
[junit4:junit4]   2> 106 T966 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47481
[junit4:junit4]   2> 106 T960 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 107 T962 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:51578
[junit4:junit4]   2> 107 T966 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47481, initiating session
[junit4:junit4]   2> 107 T962 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:51578
[junit4:junit4]   2> 108 T964 oazsp.FileTxnLog.append Creating new log file: log.1
[junit4:junit4]   2> 259 T964 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a4f9fb70a0000 with negotiated timeout 10000 for client /127.0.0.1:51578
[junit4:junit4]   2> 259 T966 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47481, sessionid = 0x13a4f9fb70a0000, negotiated timeout = 10000
[junit4:junit4]   2> 260 T967 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@204a71e6 name:ZooKeeperConnection Watcher:127.0.0.1:47481 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 260 T960 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 261 T960 oascc.SolrZkClient.makePath makePath: /solr
[junit4:junit4]   2> 263 T965 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13a4f9fb70a0000
[junit4:junit4]   2> 264 T967 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 264 T962 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:51578 which had sessionid 0x13a4f9fb70a0000
[junit4:junit4]   2> 264 T960 oaz.ZooKeeper.close Session: 0x13a4f9fb70a0000 closed
[junit4:junit4]   2> 265 T960 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47481/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@4e3d5d2d
[junit4:junit4]   2> 266 T968 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47481
[junit4:junit4]   2> 266 T960 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 267 T968 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47481, initiating session
[junit4:junit4]   2> 267 T962 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:51579
[junit4:junit4]   2> 268 T962 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:51579
[junit4:junit4]   2> 270 T964 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a4f9fb70a0001 with negotiated timeout 10000 for client /127.0.0.1:51579
[junit4:junit4]   2> 270 T968 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47481, sessionid = 0x13a4f9fb70a0001, negotiated timeout = 10000
[junit4:junit4]   2> 270 T969 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@4e3d5d2d name:ZooKeeperConnection Watcher:127.0.0.1:47481/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 271 T960 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 271 T960 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4:junit4]   2> 274 T960 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4:junit4]   2> 276 T960 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4:junit4]   2> 278 T960 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4:junit4]   2> 280 T960 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> 281 T960 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 306 T960 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> 307 T960 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4:junit4]   2> 311 T960 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> 312 T960 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 315 T960 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> 315 T960 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
[junit4:junit4]   2> 318 T960 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> 319 T960 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
[junit4:junit4]   2> 330 T960 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> 331 T960 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
[junit4:junit4]   2> 333 T960 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> 334 T960 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 356 T960 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> 357 T960 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 362 T960 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> 363 T960 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 365 T960 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> 366 T960 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
[junit4:junit4]   2> 368 T965 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13a4f9fb70a0001
[junit4:junit4]   2> 369 T969 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 369 T960 oaz.ZooKeeper.close Session: 0x13a4f9fb70a0001 closed
[junit4:junit4]   2> 369 T962 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:51579 which had sessionid 0x13a4f9fb70a0001
[junit4:junit4]   2> 370 T960 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 373 T960 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:39236
[junit4:junit4]   2> 373 T960 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 373 T960 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> 374 T960 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 391 T960 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 392 T960 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 393 T960 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> 393 T960 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> 393 T960 oasc.CoreContainer.<init> New CoreContainer 1092920872
[junit4:junit4]   2> 393 T960 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> 394 T960 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> 405 T960 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 411 T960 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:47481/solr
[junit4:junit4]   2> 412 T960 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47481/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@19664ce5
[junit4:junit4]   2> 412 T979 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47481
[junit4:junit4]   2> 412 T960 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 413 T979 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47481, initiating session
[junit4:junit4]   2> 413 T962 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:51580
[junit4:junit4]   2> 413 T962 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:51580
[junit4:junit4]   2> 417 T964 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a4f9fb70a0002 with negotiated timeout 5000 for client /127.0.0.1:51580
[junit4:junit4]   2> 417 T979 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47481, sessionid = 0x13a4f9fb70a0002, negotiated timeout = 5000
[junit4:junit4]   2> 418 T980 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@19664ce5 name:ZooKeeperConnection Watcher:127.0.0.1:47481/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 418 T960 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 419 T965 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a4f9fb70a0002 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 420 T960 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4:junit4]   2> 421 T960 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:39236_solr
[junit4:junit4]   2> 421 T965 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a4f9fb70a0002 type:delete cxid:0x7 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:39236_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:39236_solr
[junit4:junit4]   2> 421 T960 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:39236_solr
[junit4:junit4]   2> 423 T960 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 423 T960 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 423 T960 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 423 T960 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 424 T960 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 424 T960 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 424 T960 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 424 T960 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 425 T960 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 425 T960 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 428 T960 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4:junit4]   2> 432 T965 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a4f9fb70a0002 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> 432 T960 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4]   2> 434 T960 oasc.Overseer.start Overseer (id=88470690076426242-127.0.0.1:39236_solr-n_0000000000) starting
[junit4:junit4]   2> 434 T965 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a4f9fb70a0002 type:create cxid:0x1a zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 435 T965 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a4f9fb70a0002 type:create cxid:0x1b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 435 T965 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a4f9fb70a0002 type:create cxid:0x1c zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 436 T965 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a4f9fb70a0002 type:create cxid:0x1d zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 436 T982 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
[junit4:junit4]   2> 437 T960 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4:junit4]   2> 458 T960 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 459 T981 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4]   2> 462 T960 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> 462 T960 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection
[junit4:junit4]   2> 463 T960 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 463 T960 oasc.ZkController.readConfigName Load collection config from:/collections/control_collection
[junit4:junit4]   2> 464 T960 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> 465 T960 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> 465 T960 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> 489 T960 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 520 T960 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 521 T960 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 524 T960 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 804 T960 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 809 T960 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 811 T960 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 817 T960 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 820 T960 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 824 T960 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 826 T960 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 828 T960 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=./org.apache.solr.cloud.RecoveryZkTest-1349955598084/control/data/
[junit4:junit4]   2> 828 T960 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@486038e4
[junit4:junit4]   2> 838 T960 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1349955598084/control/data/index/
[junit4:junit4]   2> 838 T960 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1349955598084/control/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 839 T960 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-1349955598084/control/data/index forceNew:false
[junit4:junit4]   2> 1060 T960 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-1349955598084/control/data/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 1061 T960 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 1062 T960 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 1064 T960 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 1064 T960 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 1065 T960 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 1066 T960 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 1067 T960 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 1068 T960 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 1068 T960 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 1069 T960 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 1070 T960 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 1071 T960 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 1071 T960 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 1072 T960 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 1073 T960 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 1073 T960 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 1074 T960 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 1075 T960 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 1076 T960 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1076 T960 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1077 T960 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1078 T960 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1079 T960 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1080 T960 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1081 T960 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1082 T960 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 1083 T960 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 1087 T960 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 1090 T960 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 1091 T960 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [PROTWORDS.TXT, OLD_SYNONYMS.TXT, SCHEMA.XML, STOPWORDS.TXT, SYNONYMS.TXT, MAPPING-ISOLATIN1ACCENT.TXT, CURRENCY.XML, OPEN-EXCHANGE-RATES.JSON]
[junit4:junit4]   2> 1093 T960 oass.SolrIndexSearcher.<init> Opening Searcher@2f8bea68 main
[junit4:junit4]   2> 1094 T960 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 1094 T960 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 1095 T960 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 1099 T960 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 1357 T983 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2f8bea68 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 1363 T965 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a4f9fb70a0002 type:create cxid:0x53 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer/queue Error:KeeperErrorCode = NoNode for /solr/overseer/queue
[junit4:junit4]   2> 1366 T960 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 1367 T960 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:39236/solr shardId:control_shard
[junit4:junit4]   2> 1368 T960 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/control_shard/election
[junit4:junit4]   2> 1377 T965 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a4f9fb70a0002 type:delete cxid:0x62 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/collections/control_collection/leaders Error:KeeperErrorCode = NoNode for /solr/collections/control_collection/leaders
[junit4:junit4]   2> 1379 T960 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 1379 T965 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a4f9fb70a0002 type:create cxid:0x63 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1464 T981 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 1465 T965 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a4f9fb70a0002 type:create cxid:0x6a zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer/queue-work Error:KeeperErrorCode = NoNode for /solr/overseer/queue-work
[junit4:junit4]   2> 1473 T980 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 1880 T960 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4]   2> 1882 T960 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 1882 T960 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:39236/solr/collection1/
[junit4:junit4]   2> 1883 T960 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4:junit4]   2> 1884 T960 oasc.SyncStrategy.syncToMe http://127.0.0.1:39236/solr/collection1/ has no replicas
[junit4:junit4]   2> 1885 T960 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:39236/solr/collection1/
[junit4:junit4]   2> 1886 T960 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/control_shard
[junit4:junit4]   2> 1890 T965 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a4f9fb70a0002 type:create cxid:0x88 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1990 T981 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2029 T980 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 2077 T960 oasc.ZkController.register We are http://127.0.0.1:39236/solr/collection1/ and leader is http://127.0.0.1:39236/solr/collection1/
[junit4:junit4]   2> 2078 T960 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:39236/solr
[junit4:junit4]   2> 2078 T960 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4]   2> 2080 T960 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2081 T960 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0
[junit4:junit4]   2> 2082 T960 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 2083 T960 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 2140 T960 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 2142 T960 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:35775
[junit4:junit4]   2> 2143 T960 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 2143 T960 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty1-1349955600169
[junit4:junit4]   2> 2143 T960 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty1-1349955600169/'
[junit4:junit4]   2> 2154 T960 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 2155 T960 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 2155 T960 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty1-1349955600169
[junit4:junit4]   2> 2155 T960 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty1-1349955600169/solr.xml
[junit4:junit4]   2> 2156 T960 oasc.CoreContainer.<init> New CoreContainer 1223845012
[junit4:junit4]   2> 2156 T960 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty1-1349955600169/'
[junit4:junit4]   2> 2156 T960 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty1-1349955600169/'
[junit4:junit4]   2> 2167 T960 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 2173 T960 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:47481/solr
[junit4:junit4]   2> 2174 T960 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47481/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@3bfd8567
[junit4:junit4]   2> 2174 T993 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47481
[junit4:junit4]   2> 2174 T960 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 2175 T993 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47481, initiating session
[junit4:junit4]   2> 2175 T962 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:51581
[junit4:junit4]   2> 2175 T962 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:51581
[junit4:junit4]   2> 2187 T993 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47481, sessionid = 0x13a4f9fb70a0003, negotiated timeout = 5000
[junit4:junit4]   2> 2187 T964 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a4f9fb70a0003 with negotiated timeout 5000 for client /127.0.0.1:51581
[junit4:junit4]   2> 2187 T994 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@3bfd8567 name:ZooKeeperConnection Watcher:127.0.0.1:47481/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 2187 T960 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 2188 T965 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a4f9fb70a0003 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2189 T965 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a4f9fb70a0003 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2192 T960 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:35775_solr
[junit4:junit4]   2> 2192 T965 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a4f9fb70a0003 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:35775_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:35775_solr
[junit4:junit4]   2> 2196 T960 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:35775_solr
[junit4:junit4]   2> 2197 T980 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 2198 T960 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 2198 T960 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 2198 T960 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 2199 T960 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 2199 T960 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 2199 T960 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 2199 T960 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 2200 T960 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 2200 T960 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 2200 T960 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 2204 T960 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 2207 T960 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty1-1349955600169/collection1
[junit4:junit4]   2> 2207 T960 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 2208 T960 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 2208 T960 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 2209 T960 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty1-1349955600169/collection1/'
[junit4:junit4]   2> 2209 T960 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/solrtest-jetty1-1349955600169/collection1/lib/README' to classloader
[junit4:junit4]   2> 2210 T960 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/solrtest-jetty1-1349955600169/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 2238 T960 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 2268 T960 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 2269 T960 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 2272 T960 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 2523 T960 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 2528 T960 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 2530 T960 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 2532 T981 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2586 T994 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 2586 T980 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 2611 T960 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 2615 T960 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 2619 T960 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 2621 T960 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 2623 T960 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty1-1349955600169/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1349955598084/jetty1/
[junit4:junit4]   2> 2623 T960 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@486038e4
[junit4:junit4]   2> 2624 T960 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1349955598084/jetty1/index/
[junit4:junit4]   2> 2625 T960 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1349955598084/jetty1/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 2626 T960 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-1349955598084/jetty1/index forceNew:false
[junit4:junit4]   2> 2648 T960 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-1349955598084/jetty1/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 2648 T960 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 2649 T960 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 2651 T960 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 2652 T960 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 2653 T960 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 2653 T960 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 2654 T960 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 2655 T960 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 2655 T960 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 2656 T960 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 2657 T960 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 2658 T960 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 2658 T960 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 2659 T960 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 2660 T960 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 2661 T960 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 2662 T960 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 2663 T960 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 2664 T960 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2665 T960 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2666 T960 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2667 T960 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2668 T960 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2668 T960 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2669 T960 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2670 T960 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 2670 T960 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 2672 T960 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 2674 T960 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 2674 T960 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [PROTWORDS.TXT, OLD_SYNONYMS.TXT, SCHEMA.XML, STOPWORDS.TXT, SYNONYMS.TXT, MAPPING-ISOLATIN1ACCENT.TXT, CURRENCY.XML, OPEN-EXCHANGE-RATES.JSON]
[junit4:junit4]   2> 2676 T960 oass.SolrIndexSearcher.<init> Opening Searcher@713eadb main
[junit4:junit4]   2> 2677 T960 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 2677 T960 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 2678 T960 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 2697 T960 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 3096 T995 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@713eadb main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 3108 T981 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3126 T980 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3126 T994 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3600 T960 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 3601 T960 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:35775/solr shardId:shard1
[junit4:junit4]   2> 3601 T960 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election
[junit4:junit4]   2> 3605 T965 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a4f9fb70a0003 type:delete cxid:0x43 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/collections/collection1/leaders Error:KeeperErrorCode = NoNode for /solr/collections/collection1/leaders
[junit4:junit4]   2> 3606 T960 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 3606 T965 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a4f9fb70a0003 type:create cxid:0x44 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3607 T960 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4]   2> 3608 T960 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 3608 T960 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:35775/solr/collection1/
[junit4:junit4]   2> 3608 T960 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4:junit4]   2> 3609 T960 oasc.SyncStrategy.syncToMe http://127.0.0.1:35775/solr/collection1/ has no replicas
[junit4:junit4]   2> 3609 T960 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:35775/solr/collection1/
[junit4:junit4]   2> 3609 T960 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4:junit4]   2> 3611 T965 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a4f9fb70a0003 type:create cxid:0x4e zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3628 T981 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3636 T980 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3636 T994 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3677 T960 oasc.ZkController.register We are http://127.0.0.1:35775/solr/collection1/ and leader is http://127.0.0.1:35775/solr/collection1/
[junit4:junit4]   2> 3678 T960 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:35775/solr
[junit4:junit4]   2> 3678 T960 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4]   2> 3687 T960 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3687 T960 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0
[junit4:junit4]   2> 3688 T960 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 3688 T960 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 3735 T960 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 3737 T960 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:59957
[junit4:junit4]   2> 3737 T960 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 3738 T960 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty2-1349955601771
[junit4:junit4]   2> 3738 T960 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty2-1349955601771/'
[junit4:junit4]   2> 3749 T960 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 3749 T960 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 3749 T960 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty2-1349955601771
[junit4:junit4]   2> 3749 T960 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty2-1349955601771/solr.xml
[junit4:junit4]   2> 3750 T960 oasc.CoreContainer.<init> New CoreContainer 1960178455
[junit4:junit4]   2> 3750 T960 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty2-1349955601771/'
[junit4:junit4]   2> 3750 T960 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty2-1349955601771/'
[junit4:junit4]   2> 3761 T960 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 3767 T960 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:47481/solr
[junit4:junit4]   2> 3768 T960 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47481/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@4adeaabb
[junit4:junit4]   2> 3769 T1005 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47481
[junit4:junit4]   2> 3769 T960 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 3769 T1005 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47481, initiating session
[junit4:junit4]   2> 3769 T962 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:51582
[junit4:junit4]   2> 3770 T962 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:51582
[junit4:junit4]   2> 3772 T964 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a4f9fb70a0004 with negotiated timeout 5000 for client /127.0.0.1:51582
[junit4:junit4]   2> 3772 T1005 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47481, sessionid = 0x13a4f9fb70a0004, negotiated timeout = 5000
[junit4:junit4]   2> 3773 T1006 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@4adeaabb name:ZooKeeperConnection Watcher:127.0.0.1:47481/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 3773 T960 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 3773 T965 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a4f9fb70a0004 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3774 T965 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a4f9fb70a0004 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3774 T960 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59957_solr
[junit4:junit4]   2> 3775 T965 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a4f9fb70a0004 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:59957_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:59957_solr
[junit4:junit4]   2> 3786 T960 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:59957_solr
[junit4:junit4]   2> 3788 T980 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 3788 T994 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 3789 T960 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 3789 T960 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 3789 T960 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 3790 T960 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 3790 T960 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 3791 T960 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 3791 T960 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 3791 T960 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 3792 T960 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 3792 T960 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 4146 T981 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 4147 T960 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 4149 T994 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4149 T980 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4150 T1006 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4152 T960 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty2-1349955601771/collection1
[junit4:junit4]   2> 4152 T960 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 4152 T960 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 4153 T960 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 4153 T960 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty2-1349955601771/collection1/'
[junit4:junit4]   2> 4154 T960 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/solrtest-jetty2-1349955601771/collection1/lib/README' to classloader
[junit4:junit4]   2> 4154 T960 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/solrtest-jetty2-1349955601771/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 4183 T960 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 4217 T960 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 4218 T960 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 4223 T960 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 4485 T960 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 4491 T960 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 4493 T960 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 4499 T960 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 4502 T960 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 4505 T960 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 4506 T960 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 4506 T960 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty2-1349955601771/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1349955598084/jetty2/
[junit4:junit4]   2> 4507 T960 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@486038e4
[junit4:junit4]   2> 4507 T960 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1349955598084/jetty2/index/
[junit4:junit4]   2> 4508 T960 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1349955598084/jetty2/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 4508 T960 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-1349955598084/jetty2/index forceNew:false
[junit4:junit4]   2> 4537 T960 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-1349955598084/jetty2/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 4538 T960 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 4538 T960 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 4539 T960 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 4540 T960 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 4540 T960 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 4540 T960 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 4541 T960 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 4541 T960 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 4541 T960 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 4542 T960 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 4542 T960 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 4543 T960 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 4543 T960 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 4543 T960 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 4544 T960 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 4544 T960 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 4544 T960 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 4545 T960 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 4545 T960 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4546 T960 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4546 T960 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4546 T960 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4547 T960 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4547 T960 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4548 T960 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4548 T960 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 4548 T960 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 4551 T960 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 4552 T960 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 4554 T960 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [PROTWORDS.TXT, OLD_SYNONYMS.TXT, SCHEMA.XML, STOPWORDS.TXT, SYNONYMS.TXT, MAPPING-ISOLATIN1ACCENT.TXT, CURRENCY.XML, OPEN-EXCHANGE-RATES.JSON]
[junit4:junit4]   2> 4556 T960 oass.SolrIndexSearcher.<init> Opening Searcher@7eff54a5 main
[junit4:junit4]   2> 4557 T960 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 4557 T960 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 4557 T960 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 4568 T960 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 4596 T1007 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7eff54a5 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 4652 T981 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 4655 T980 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4655 T1006 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4655 T994 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5099 T960 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 5099 T960 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:59957/solr shardId:shard1
[junit4:junit4]   2> 5102 T960 oasc.ZkController.register We are http://127.0.0.1:59957/solr/collection1/ and leader is http://127.0.0.1:35775/solr/collection1/
[junit4:junit4]   2> 5102 T960 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:59957/solr
[junit4:junit4]   2> 5102 T960 oasc.ZkController.checkRecovery Core needs to recover:collection1
[junit4:junit4]   2> 5103 T960 oasu.DefaultSolrCoreState.doRecovery Running recovery - first canceling any ongoing recovery
[junit4:junit4]   2> ASYNC  NEW_CORE C54 name=collection1 org.apache.solr.core.SolrCore@7a113669 url=http://127.0.0.1:59957/solr/collection1 node=127.0.0.1:59957_solr
[junit4:junit4]   2> 5103 T1008 C54 P59957 oasc.RecoveryStrategy.run Starting recovery process.  core=collection1 recoveringAfterStartup=true
[junit4:junit4]   2> 5104 T1008 C54 P59957 oasc.RecoveryStrategy.doRecovery ###### startupVersions=[]
[junit4:junit4]   2> 5103 T960 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 5104 T1008 C54 P59957 oasc.RecoveryStrategy.doRecovery Attempting to PeerSync from http://127.0.0.1:35775/solr/collection1/ core=collection1 - recoveringAfterStartup=true
[junit4:junit4]   2> 5104 T1008 C54 P59957 oasu.PeerSync.sync PeerSync: core=collection1 url=http://127.0.0.1:59957/solr START replicas=[http://127.0.0.1:35775/solr/collection1/] nUpdates=100
[junit4:junit4]   2> 5104 T960 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0
[junit4:junit4]   2> 5105 T1008 C54 P59957 oasu.PeerSync.sync WARNING no frame of reference to tell of we've missed updates
[junit4:junit4]   2> 5105 T1008 C54 P59957 oasc.RecoveryStrategy.doRecovery PeerSync Recovery was not successful - trying replication. core=collection1
[junit4:junit4]   2> 5105 T1008 C54 P59957 oasc.RecoveryStrategy.doRecovery Starting Replication Recovery. core=collection1
[junit4:junit4]   2> 5105 T1008 C54 P59957 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 5105 T960 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 5106 T960 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 5108 T960 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47481/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@6746e928
[junit4:junit4]   2> 5109 T960 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 5111 T1010 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47481
[junit4:junit4]   2> 5111 T962 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:51585
[junit4:junit4]   2> ASYNC  NEW_CORE C55 name=collection1 org.apache.solr.core.SolrCore@74834dbc url=http://127.0.0.1:35775/solr/collection1 node=127.0.0.1:35775_solr
[junit4:junit4]   2> 5112 T986 C55 P35775 REQ /get {qt=/get&distrib=false&getVersions=100&version=2&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 5112 T1010 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47481, initiating session
[junit4:junit4]   2> 5113 T962 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:51585
[junit4:junit4]   2> 5126 T964 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a4f9fb70a0005 with negotiated timeout 10000 for client /127.0.0.1:51585
[junit4:junit4]   2> 5126 T1010 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47481, sessionid = 0x13a4f9fb70a0005, negotiated timeout = 10000
[junit4:junit4]   2> 5127 T1011 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6746e928 name:ZooKeeperConnection Watcher:127.0.0.1:47481/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 5127 T960 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 5129 T960 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 5130 T960 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:true cause connection loss:true
[junit4:junit4]   2> 5130 T960 oascsi.HttpClientUtil.createClient Creating new http client, config:
[junit4:junit4]   2> 5133 T960 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> ASYNC  NEW_CORE C56 name=collection1 org.apache.solr.core.SolrCore@444cb796 url=http://127.0.0.1:39236/solr/collection1 node=127.0.0.1:39236_solr
[junit4:junit4]   2> 5143 T973 C56 P39236 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-1349955598084/control/data/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 5144 T973 C56 P39236 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 5150 T973 C56 P39236 /update {version=2&wt=javabin} {add=[1 (1415531046604111872)]} 0 9
[junit4:junit4]   2> 5150 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10001 (1415531046604111873)]} 0 9
[junit4:junit4]   2> 5151 T1012 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47481/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@468e9987
[junit4:junit4]   2> 5153 T1014 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47481
[junit4:junit4]   2> 5153 T1012 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 5154 T1014 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47481, initiating session
[junit4:junit4]   2> 5154 T962 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:51589
[junit4:junit4]   2> 5154 T962 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:51589
[junit4:junit4]   2> 5156 T964 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a4f9fb70a0006 with negotiated timeout 10000 for client /127.0.0.1:51589
[junit4:junit4]   2> 5156 T1014 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47481, sessionid = 0x13a4f9fb70a0006, negotiated timeout = 10000
[junit4:junit4]   2> 5156 T1015 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@468e9987 name:ZooKeeperConnection Watcher:127.0.0.1:47481/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 5156 T1012 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 5158 T1012 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 5158 T981 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 5161 T1006 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5161 T994 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5161 T980 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5163 T988 C55 P35775 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-1349955598084/jetty1/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 5163 T1015 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5163 T1011 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5164 T988 C55 P35775 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 5166 T989 C55 P35775 /update {version=2&wt=javabin} {add=[1 (1415531046625083393)]} 0 6
[junit4:junit4]   2> 5167 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10001 (1415531046625083392)]} 0 7
[junit4:junit4]   2> 5169 T972 C56 P39236 /update {version=2&wt=javabin} {add=[2 (1415531046632423424)]} 0 1
[junit4:junit4]   2> 5169 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10002 (1415531046633472000)]} 0 0
[junit4:junit4]   2>  C54_STATE=coll:collection1 core:collection1 props:{roles=null, core=collection1, collection=collection1, state=recovering, shard=shard1, node_name=127.0.0.1:59957_solr, base_url=http://127.0.0.1:59957/solr}
[junit4:junit4]   2> 5177 T999 C54 P59957 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-1349955598084/jetty2/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 5178 T999 C54 P59957 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 5180 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=5 
[junit4:junit4]   2> 5180 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=5 
[junit4:junit4]   2> 5180 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10002 (1415531046635569152)]} 0 9
[junit4:junit4]   2> 5180 T988 C55 P35775 /update {version=2&wt=javabin} {add=[2 (1415531046634520576)]} 0 10
[junit4:junit4]   2> 5183 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[2 (-1415531046648152064)]} 0 1
[junit4:junit4]   2> 5183 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[10002 (-1415531046648152065)]} 0 1
[junit4:junit4]   2> 5191 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5191 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5192 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[10002 (-1415531046650249217)]} 0 7
[junit4:junit4]   2> 5194 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[2 (-1415531046650249216)]} 0 9
[junit4:junit4]   2> 5197 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10003 (1415531046661783552)]} 0 1
[junit4:junit4]   2> 5197 T972 C56 P39236 /update {version=2&wt=javabin} {add=[3 (1415531046661783553)]} 0 1
[junit4:junit4]   2> 5202 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5202 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5203 T989 C55 P35775 /update {version=2&wt=javabin} {add=[3 (1415531046664929280)]} 0 4
[junit4:junit4]   2> 5203 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10003 (1415531046664929281)]} 0 4
[junit4:junit4]   2> 5205 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10004 (1415531046671220737)]} 0 0
[junit4:junit4]   2> 5205 T973 C56 P39236 /update {version=2&wt=javabin} {add=[4 (1415531046671220736)]} 0 0
[junit4:junit4]   2> 5209 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5209 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5210 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10004 (1415531046673317889)]} 0 3
[junit4:junit4]   2> 5210 T989 C55 P35775 /update {version=2&wt=javabin} {add=[4 (1415531046673317888)]} 0 3
[junit4:junit4]   2> 5212 T973 C56 P39236 /update {version=2&wt=javabin} {add=[5 (1415531046678560768)]} 0 0
[junit4:junit4]   2> 5213 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10005 (1415531046679609344)]} 0 0
[junit4:junit4]   2> 5217 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5217 T988 C55 P35775 /update {version=2&wt=javabin} {add=[5 (1415531046680657920)]} 0 3
[junit4:junit4]   2> 5219 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[5 (-1415531046685900800)]} 0 0
[junit4:junit4]   2> 5223 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5223 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[5 (-1415531046687997952)]} 0 2
[junit4:junit4]   2> 5224 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5224 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10005 (1415531046681706496)]} 0 9
[junit4:junit4]   2> 5226 T972 C56 P39236 /update {version=2&wt=javabin} {add=[6 (1415531046692192256)]} 0 1
[junit4:junit4]   2> 5226 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[10005 (-1415531046693240832)]} 0 0
[junit4:junit4]   2> 5229 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5229 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10005 (-1415531046694289409)]} 0 2
[junit4:junit4]   2> 5230 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5230 T989 C55 P35775 /update {version=2&wt=javabin} {add=[6 (1415531046694289408)]} 0 3
[junit4:junit4]   2> 5231 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10006 (1415531046698483712)]} 0 0
[junit4:junit4]   2> 5232 T972 C56 P39236 /update {version=2&wt=javabin} {add=[7 (1415531046699532288)]} 0 1
[junit4:junit4]   2> 5235 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5235 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5235 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10006 (1415531046700580864)]} 0 2
[junit4:junit4]   2> 5236 T988 C55 P35775 /update {version=2&wt=javabin} {add=[7 (1415531046700580865)]} 0 3
[junit4:junit4]   2> 5238 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10007 (1415531046705823744)]} 0 0
[junit4:junit4]   2> 5238 T973 C56 P39236 /update {version=2&wt=javabin} {add=[8 (1415531046705823745)]} 0 0
[junit4:junit4]   2> 5242 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5244 T989 C55 P35775 /update {version=2&wt=javabin} {add=[8 (1415531046707920897)]} 0 4
[junit4:junit4]   2> 5246 T973 C56 P39236 /update {version=2&wt=javabin} {add=[9 (1415531046714212352)]} 0 0
[junit4:junit4]   2> 5248 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5249 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10007 (1415531046707920896)]} 0 9
[junit4:junit4]   2> 5252 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10008 (1415531046719455232)]} 0 1
[junit4:junit4]   2> 5252 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5252 T989 C55 P35775 /update {version=2&wt=javabin} {add=[9 (1415531046717358080)]} 0 4
[junit4:junit4]   2> 5260 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5261 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10008 (1415531046722600960)]} 0 7
[junit4:junit4]   2> 5263 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10009 (1415531046732038144)]} 0 0
[junit4:junit4]   2> 5263 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10 (1415531046722600960)]} 0 9
[junit4:junit4]   2> 5268 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5268 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10 (1415531046734135297)]} 0 3
[junit4:junit4]   2> 5271 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[7 (-1415531046740426752)]} 0 0
[junit4:junit4]   2> 5277 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5278 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[7 (-1415531046744621056)]} 0 3
[junit4:junit4]   2> 5280 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=10 
[junit4:junit4]   2> 5281 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10009 (1415531046734135296)]} 0 16
[junit4:junit4]   2> 5281 T973 C56 P39236 /update {version=2&wt=javabin} {add=[11 (1415531046749863936)]} 0 1
[junit4:junit4]   2> 5301 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5302 T988 C55 P35775 /update {version=2&wt=javabin} {add=[11 (1415531046753009664)]} 0 19
[junit4:junit4]   2> 5304 T973 C56 P39236 /update {version=2&wt=javabin} {add=[12 (1415531046775029760)]} 0 0
[junit4:junit4]   2> 5310 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10010 (1415531046753009664)]} 0 27
[junit4:junit4]   2> 5313 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5313 T988 C55 P35775 /update {version=2&wt=javabin} {add=[12 (1415531046778175488)]} 0 6
[junit4:junit4]   2> 5314 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5315 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10010 (1415531046783418368)]} 0 3
[junit4:junit4]   2> 5315 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[9 (-1415531046786564096)]} 0 0
[junit4:junit4]   2> 5317 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[10007 (-1415531046788661248)]} 0 0
[junit4:junit4]   2> 5319 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5320 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[9 (-1415531046788661248)]} 0 3
[junit4:junit4]   2> 5321 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5322 T973 C56 P39236 /update {version=2&wt=javabin} {add=[13 (1415531046793904128)]} 0 1
[junit4:junit4]   2> 5323 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10007 (-1415531046790758400)]} 0 4
[junit4:junit4]   2> 5326 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10011 (1415531046798098432)]} 0 1
[junit4:junit4]   2> 5327 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5328 T989 C55 P35775 /update {version=2&wt=javabin} {add=[13 (1415531046796001280)]} 0 4
[junit4:junit4]   2> 5330 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5330 T973 C56 P39236 /update {version=2&wt=javabin} {add=[14 (1415531046802292736)]} 0 0
[junit4:junit4]   2> 5333 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10011 (1415531046800195584)]} 0 5
[junit4:junit4]   2> 5335 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5335 T989 C55 P35775 /update {version=2&wt=javabin} {add=[14 (1415531046804389888)]} 0 3
[junit4:junit4]   2> 5336 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10012 (1415531046807535616)]} 0 1
[junit4:junit4]   2> 5337 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[10 (-1415531046809632768)]} 0 0
[junit4:junit4]   2> 5340 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5341 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10012 (1415531046810681344)]} 0 3
[junit4:junit4]   2> 5343 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[10009 (-1415531046815924224)]} 0 0
[junit4:junit4]   2> 5343 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5344 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10 (-1415531046812778496)]} 0 4
[junit4:junit4]   2> 5347 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5347 T972 C56 P39236 /update {version=2&wt=javabin} {add=[15 (1415531046819069952)]} 0 1
[junit4:junit4]   2> 5347 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[10009 (-1415531046818021376)]} 0 2
[junit4:junit4]   2> 5349 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10013 (1415531046822215680)]} 0 0
[junit4:junit4]   2> 5351 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5353 T988 C55 P35775 /update {version=2&wt=javabin} {add=[15 (1415531046822215680)]} 0 4
[junit4:junit4]   2> 5354 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5354 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10013 (1415531046824312832)]} 0 3
[junit4:junit4]   2> 5355 T972 C56 P39236 /update {version=2&wt=javabin} {add=[16 (1415531046828507136)]} 0 0
[junit4:junit4]   2> 5357 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10014 (1415531046830604288)]} 0 1
[junit4:junit4]   2> 5360 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5361 T989 C55 P35775 /update {version=2&wt=javabin} {add=[16 (1415531046831652864)]} 0 3
[junit4:junit4]   2> 5363 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[12 (-1415531046836895744)]} 0 0
[junit4:junit4]   2> 5370 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5370 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[12 (-1415531046838992896)]} 0 5
[junit4:junit4]   2> 5373 T973 C56 P39236 /update {version=2&wt=javabin} {add=[17 (1415531046846332928)]} 0 1
[junit4:junit4]   2> 5374 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5375 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10014 (1415531046836895744)]} 0 12
[junit4:junit4]   2> 5377 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[10010 (-1415531046851575808)]} 0 0
[junit4:junit4]   2> 5384 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5387 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10010 (-1415531046857867264)]} 0 4
[junit4:junit4]   2> 5388 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=9 
[junit4:junit4]   2> 5388 T989 C55 P35775 /update {version=2&wt=javabin} {add=[17 (1415531046849478656)]} 0 13
[junit4:junit4]   2> 5390 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10015 (1415531046865207296)]} 0 1
[junit4:junit4]   2> 5390 T972 C56 P39236 /update {version=2&wt=javabin} {add=[18 (1415531046865207297)]} 0 0
[junit4:junit4]   2> 5396 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5397 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10015 (1415531046868353025)]} 0 4
[junit4:junit4]   2> 5407 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=11 
[junit4:junit4]   2> 5411 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10016 (1415531046874644480)]} 0 12
[junit4:junit4]   2> 5411 T989 C55 P35775 /update {version=2&wt=javabin} {add=[18 (1415531046868353024)]} 0 19
[junit4:junit4]   2> 5415 T973 C56 P39236 /update {version=2&wt=javabin} {add=[19 (1415531046891421696)]} 0 1
[junit4:junit4]   2> 5417 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5417 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10016 (1415531046890373120)]} 0 4
[junit4:junit4]   2> 5420 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[10012 (-1415531046896664576)]} 0 1
[junit4:junit4]   2> 5420 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5420 T989 C55 P35775 /update {version=2&wt=javabin} {add=[19 (1415531046894567424)]} 0 2
[junit4:junit4]   2> 5424 T973 C56 P39236 /update {version=2&wt=javabin} {add=[20 (1415531046900858880)]} 0 0
[junit4:junit4]   2> 5426 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5428 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5429 T989 C55 P35775 /update {version=2&wt=javabin} {add=[20 (1415531046902956032)]} 0 3
[junit4:junit4]   2> 5429 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10012 (-1415531046900858880)]} 0 5
[junit4:junit4]   2> 5432 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10017 (1415531046908198912)]} 0 1
[junit4:junit4]   2> 5433 T973 C56 P39236 /update {version=2&wt=javabin} {add=[21 (1415531046910296064)]} 0 0
[junit4:junit4]   2> 5436 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5437 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10017 (1415531046911344640)]} 0 3
[junit4:junit4]   2> 5438 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5439 T989 C55 P35775 /update {version=2&wt=javabin} {add=[21 (1415531046913441792)]} 0 3
[junit4:junit4]   2> 5439 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10018 (1415531046916587520)]} 0 0
[junit4:junit4]   2> 5441 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[14 (-1415531046918684672)]} 0 0
[junit4:junit4]   2> 5443 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5444 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10018 (1415531046918684672)]} 0 3
[junit4:junit4]   2> 5444 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5445 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[14 (-1415531046920781824)]} 0 2
[junit4:junit4]   2> 5446 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10019 (1415531046923927552)]} 0 0
[junit4:junit4]   2> 5447 T973 C56 P39236 /update {version=2&wt=javabin} {add=[22 (1415531046923927553)]} 0 1
[junit4:junit4]   2> 5451 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5452 T989 C55 P35775 /update {version=2&wt=javabin} {add=[22 (1415531046926024705)]} 0 4
[junit4:junit4]   2> 5459 T973 C56 P39236 /update {version=2&wt=javabin} {add=[23 (1415531046936510464)]} 0 1
[junit4:junit4]   2> 5459 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5460 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10019 (1415531046926024704)]} 0 12
[junit4:junit4]   2> 5462 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10020 (1415531046939656192)]} 0 1
[junit4:junit4]   2> 5463 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5463 T989 C55 P35775 /update {version=2&wt=javabin} {add=[23 (1415531046939656192)]} 0 2
[junit4:junit4]   2> 5465 T973 C56 P39236 /update {version=2&wt=javabin} {add=[24 (1415531046943850496)]} 0 0
[junit4:junit4]   2> 5465 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5466 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10020 (1415531046942801920)]} 0 2
[junit4:junit4]   2> 5468 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10021 (1415531046946996224)]} 0 0
[junit4:junit4]   2> 5469 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5469 T989 C55 P35775 /update {version=2&wt=javabin} {add=[24 (1415531046945947648)]} 0 2
[junit4:junit4]   2> 5472 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[17 (-1415531046950141952)]} 0 1
[junit4:junit4]   2> 5476 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5476 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[17 (-1415531046953287680)]} 0 2
[junit4:junit4]   2> 5481 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=9 
[junit4:junit4]   2> 5481 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10021 (1415531046949093376)]} 0 11
[junit4:junit4]   2> 5484 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[10014 (-1415531046962724864)]} 0 1
[junit4:junit4]   2> 5485 T973 C56 P39236 /update {version=2&wt=javabin} {add=[25 (1415531046957481984)]} 0 7
[junit4:junit4]   2> 5487 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5488 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10014 (-1415531046965870592)]} 0 2
[junit4:junit4]   2> 5489 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5489 T989 C55 P35775 /update {version=2&wt=javabin} {add=[25 (1415531046966919168)]} 0 2
[junit4:junit4]   2> 5490 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10022 (1415531046969016320)]} 0 1
[junit4:junit4]   2> 5491 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[19 (-1415531046971113472)]} 0 0
[junit4:junit4]   2> 5495 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5495 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5495 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[19 (-1415531046973210624)]} 0 2
[junit4:junit4]   2> 5496 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10022 (1415531046972162048)]} 0 4
[junit4:junit4]   2> 5498 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10023 (1415531046977404929)]} 0 1
[junit4:junit4]   2> 5498 T973 C56 P39236 /update {version=2&wt=javabin} {add=[26 (1415531046977404928)]} 0 1
[junit4:junit4]   2> 5502 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5503 T988 C55 P35775 /update {version=2&wt=javabin} {add=[26 (1415531046980550656)]} 0 3
[junit4:junit4]   2> 5504 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5504 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10023 (1415531046980550657)]} 0 4
[junit4:junit4]   2> 5506 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10024 (1415531046986842112)]} 0 0
[junit4:junit4]   2> 5507 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[20 (-1415531046987890688)]} 0 0
[junit4:junit4]   2> 5514 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5514 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[20 (-1415531046992084992)]} 0 3
[junit4:junit4]   2> 5517 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5517 T973 C56 P39236 /update {version=2&wt=javabin} {add=[27 (1415531046997327872)]} 0 1
[junit4:junit4]   2> 5517 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10024 (1415531046988939264)]} 0 9
[junit4:junit4]   2> 5519 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[10017 (-1415531047000473600)]} 0 0
[junit4:junit4]   2> 5522 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5522 T988 C55 P35775 /update {version=2&wt=javabin} {add=[27 (1415531047000473600)]} 0 3
[junit4:junit4]   2> 5523 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5524 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[10017 (-1415531047003619328)]} 0 3
[junit4:junit4]   2> 5525 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[21 (-1415531047005716480)]} 0 1
[junit4:junit4]   2> 5526 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10025 (1415531047006765056)]} 0 1
[junit4:junit4]   2> 5528 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5529 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[21 (-1415531047008862208)]} 0 2
[junit4:junit4]   2> 5530 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5530 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10025 (1415531047009910784)]} 0 2
[junit4:junit4]   2> 5534 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[10019 (-1415531047016202240)]} 0 0
[junit4:junit4]   2> 5538 T972 C56 P39236 /update {version=2&wt=javabin} {add=[28 (1415531047013056512)]} 0 7
[junit4:junit4]   2> 5539 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5539 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10019 (-1415531047019347968)]} 0 3
[junit4:junit4]   2> 5542 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10026 (1415531047023542272)]} 0 1
[junit4:junit4]   2> 5546 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5547 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10026 (1415531047026688000)]} 0 3
[junit4:junit4]   2> 5549 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[10020 (-1415531047031930880)]} 0 0
[junit4:junit4]   2> 5550 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5551 T989 C55 P35775 /update {version=2&wt=javabin} {add=[28 (1415531047022493696)]} 0 11
[junit4:junit4]   2> 5553 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[22 (-1415531047036125184)]} 0 0
[junit4:junit4]   2> 5554 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5554 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10020 (-1415531047034028032)]} 0 3
[junit4:junit4]   2> 5556 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10027 (1415531047039270912)]} 0 0
[junit4:junit4]   2> 5557 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5557 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[22 (-1415531047038222336)]} 0 2
[junit4:junit4]   2> 5560 T972 C56 P39236 /update {version=2&wt=javabin} {add=[29 (1415531047042416640)]} 0 1
[junit4:junit4]   2> 5560 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5561 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10027 (1415531047041368064)]} 0 3
[junit4:junit4]   2> 5565 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5566 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[10021 (-1415531047049756672)]} 0 0
[junit4:junit4]   2> 5566 T989 C55 P35775 /update {version=2&wt=javabin} {add=[29 (1415531047046610944)]} 0 3
[junit4:junit4]   2> 5568 T972 C56 P39236 /update {version=2&wt=javabin} {add=[30 (1415531047051853824)]} 0 0
[junit4:junit4]   2> 5570 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5570 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10021 (-1415531047051853824)]} 0 2
[junit4:junit4]   2> 5573 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10028 (1415531047056048128)]} 0 1
[junit4:junit4]   2> 5575 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5576 T989 C55 P35775 /update {version=2&wt=javabin} {add=[30 (1415531047053950976)]} 0 6
[junit4:junit4]   2> 5579 T973 C56 P39236 /update {version=2&wt=javabin} {add=[31 (1415531047062339584)]} 0 1
[junit4:junit4]   2> 5582 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5582 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10028 (1415531047063388160)]} 0 3
[junit4:junit4]   2> 5583 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5584 T988 C55 P35775 /update {version=2&wt=javabin} {add=[31 (1415531047065485312)]} 0 3
[junit4:junit4]   2> 5585 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[10022 (-1415531047069679616)]} 0 0
[junit4:junit4]   2> 5586 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[23 (-1415531047070728192)]} 0 0
[junit4:junit4]   2> 5589 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5590 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10022 (-1415531047071776768)]} 0 3
[junit4:junit4]   2> 5591 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5591 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[23 (-1415531047072825344)]} 0 3
[junit4:junit4]   2> 5592 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10029 (1415531047077019648)]} 0 0
[junit4:junit4]   2> 5594 T973 C56 P39236 /update {version=2&wt=javabin} {add=[32 (1415531047078068224)]} 0 1
[junit4:junit4]   2> 5606 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5607 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10029 (1415531047079116800)]} 0 13
[junit4:junit4]   2> 5609 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10030 (1415531047094845440)]} 0 0
[junit4:junit4]   2> 5615 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=16 
[junit4:junit4]   2> 5615 T988 C55 P35775 /update {version=2&wt=javabin} {add=[32 (1415531047081213952)]} 0 19
[junit4:junit4]   2> 5618 T973 C56 P39236 /update {version=2&wt=javabin} {add=[33 (1415531047104282624)]} 0 0
[junit4:junit4]   2> 5622 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=6 
[junit4:junit4]   2> 5623 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5624 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10030 (1415531047099039744)]} 0 11
[junit4:junit4]   2> 5626 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10031 (1415531047112671232)]} 0 0
[junit4:junit4]   2> 5627 T988 C55 P35775 /update {version=2&wt=javabin} {add=[33 (1415531047106379776)]} 0 7
[junit4:junit4]   2> 5629 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[27 (-1415531047115816960)]} 0 0
[junit4:junit4]   2> 5632 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5633 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10031 (1415531047115816960)]} 0 5
[junit4:junit4]   2> 5633 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5634 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[27 (-1415531047118962688)]} 0 2
[junit4:junit4]   2> 5635 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[10023 (-1415531047122108416)]} 0 0
[junit4:junit4]   2> 5636 T972 C56 P39236 /update {version=2&wt=javabin} {add=[34 (1415531047123156992)]} 0 0
[junit4:junit4]   2> 5639 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5640 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10023 (-1415531047125254144)]} 0 3
[junit4:junit4]   2> 5641 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5642 T989 C55 P35775 /update {version=2&wt=javabin} {add=[34 (1415531047125254145)]} 0 4
[junit4:junit4]   2> 5642 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10032 (1415531047129448448)]} 0 0
[junit4:junit4]   2> 5644 T973 C56 P39236 /update {version=2&wt=javabin} {add=[35 (1415531047131545600)]} 0 0
[junit4:junit4]   2> 5647 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5648 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10032 (1415531047131545600)]} 0 4
[junit4:junit4]   2> 5649 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5650 T988 C55 P35775 /update {version=2&wt=javabin} {add=[35 (1415531047133642752)]} 0 4
[junit4:junit4]   2> 5657 T972 C56 P39236 /update {version=2&wt=javabin} {add=[36 (1415531047145177088)]} 0 0
[junit4:junit4]   2> 5662 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5663 T988 C55 P35775 /update {version=2&wt=javabin} {add=[36 (1415531047148322816)]} 0 3
[junit4:junit4]   2> 5666 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[29 (-1415531047154614272)]} 0 0
[junit4:junit4]   2> 5662 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10033 (1415531047139934208)]} 0 10
[junit4:junit4]   2> 5670 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5671 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[29 (-1415531047156711424)]} 0 3
[junit4:junit4]   2> 5675 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5675 T973 C56 P39236 /update {version=2&wt=javabin} {add=[37 (1415531047161954304)]} 0 2
[junit4:junit4]   2> 5676 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10033 (1415531047160905728)]} 0 5
[junit4:junit4]   2> 5680 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[10027 (-1415531047168245760)]} 0 1
[junit4:junit4]   2> 5684 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5684 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[10027 (-1415531047171391488)]} 0 2
[junit4:junit4]   2> 5687 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10034 (1415531047175585792)]} 0 1
[junit4:junit4]   2> 5691 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5691 T988 C55 P35775 /update {version=2&wt=javabin} {add=[37 (1415531047167197184)]} 0 14
[junit4:junit4]   2> 5692 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5692 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10034 (1415531047178731520)]} 0 3
[junit4:junit4]   2> 5695 T973 C56 P39236 /update {version=2&wt=javabin} {add=[38 (1415531047185022976)]} 0 0
[junit4:junit4]   2> 5700 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5701 T989 C55 P35775 /update {version=2&wt=javabin} {add=[38 (1415531047188168704)]} 0 3
[junit4:junit4]   2> 5704 T973 C56 P39236 /update {version=2&wt=javabin} {add=[39 (1415531047194460160)]} 0 0
[junit4:junit4]   2> 5709 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5709 T989 C55 P35775 /update {version=2&wt=javabin} {add=[39 (1415531047196557312)]} 0 3
[junit4:junit4]   2> 5712 T973 C56 P39236 /update {version=2&wt=javabin} {add=[40 (1415531047201800192)]} 0 1
[junit4:junit4]   2> 5716 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5717 T989 C55 P35775 /update {version=2&wt=javabin} {add=[40 (1415531047204945920)]} 0 3
[junit4:junit4]   2> 5718 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10035 (1415531047192363008)]} 0 16
[junit4:junit4]   2> 5720 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[30 (-1415531047210188800)]} 0 1
[junit4:junit4]   2> 5723 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5723 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5724 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10035 (1415531047211237376)]} 0 4
[junit4:junit4]   2> 5725 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[30 (-1415531047213334528)]} 0 3
[junit4:junit4]   2> 5727 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10036 (1415531047217528832)]} 0 1
[junit4:junit4]   2> 5728 T972 C56 P39236 /update {version=2&wt=javabin} {add=[41 (1415531047218577408)]} 0 1
[junit4:junit4]   2> 5733 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5734 T989 C55 P35775 /update {version=2&wt=javabin} {add=[41 (1415531047222771712)]} 0 3
[junit4:junit4]   2> 5737 T972 C56 P39236 /update {version=2&wt=javabin} {add=[42 (1415531047228014592)]} 0 1
[junit4:junit4]   2> 5743 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5744 T989 C55 P35775 /update {version=2&wt=javabin} {add=[42 (1415531047231160320)]} 0 5
[junit4:junit4]   2> 5746 T972 C56 P39236 /update {version=2&wt=javabin} {add=[43 (1415531047238500352)]} 0 0
[junit4:junit4]   2> 5750 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=19 
[junit4:junit4]   2> 5751 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5752 T989 C55 P35775 /update {version=2&wt=javabin} {add=[43 (1415531047241646080)]} 0 3
[junit4:junit4]   2> 5752 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10036 (1415531047221723136)]} 0 22
[junit4:junit4]   2> 5754 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[10029 (-1415531047246888961)]} 0 0
[junit4:junit4]   2> 5754 T972 C56 P39236 /update {version=2&wt=javabin} {add=[44 (1415531047246888960)]} 0 0
[junit4:junit4]   2> 5758 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5759 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10029 (-1415531047248986113)]} 0 3
[junit4:junit4]   2> 5761 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10037 (1415531047254228992)]} 0 0
[junit4:junit4]   2> 5767 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5768 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10037 (1415531047256326144)]} 0 5
[junit4:junit4]   2> 5771 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10038 (1415531047263666176)]} 0 1
[junit4:junit4]   2> 5776 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5777 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10038 (1415531047266811904)]} 0 4
[junit4:junit4]   2> 5780 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10039 (1415531047273103360)]} 0 1
[junit4:junit4]   2> 5785 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5785 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10039 (1415531047276249088)]} 0 3
[junit4:junit4]   2> 5788 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10040 (1415531047282540544)]} 0 0
[junit4:junit4]   2> 5794 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5795 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10040 (1415531047285686272)]} 0 4
[junit4:junit4]   2> 5797 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[10030 (-1415531047291977728)]} 0 0
[junit4:junit4]   2> 5802 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5803 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10030 (-1415531047295123456)]} 0 3
[junit4:junit4]   2> 5806 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10041 (1415531047301414912)]} 0 1
[junit4:junit4]   2> 5811 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5812 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10041 (1415531047304560640)]} 0 4
[junit4:junit4]   2> 5833 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5833 T989 C55 P35775 /update {version=2&wt=javabin} {add=[44 (1415531047248986112)]} 0 77
[junit4:junit4]   2> 5849 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[32 (-1415531047346503680)]} 0 0
[junit4:junit4]   2> 5855 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5856 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[32 (-1415531047349649408)]} 0 4
[junit4:junit4]   2> 5859 T973 C56 P39236 /update {version=2&wt=javabin} {add=[45 (1415531047356989440)]} 0 0
[junit4:junit4]   2> 5867 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5869 T989 C55 P35775 /update {version=2&wt=javabin} {add=[45 (1415531047361183744)]} 0 7
[junit4:junit4]   2> 5871 T973 C56 P39236 /update {version=2&wt=javabin} {add=[46 (1415531047369572352)]} 0 0
[junit4:junit4]   2> 5881 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5882 T989 C55 P35775 /update {version=2&wt=javabin} {add=[46 (1415531047374815232)]} 0 6
[junit4:junit4]   2> 5885 T973 C56 P39236 /update {version=2&wt=javabin} {add=[47 (1415531047384252416)]} 0 1
[junit4:junit4]   2> 5894 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5895 T989 C55 P35775 /update {version=2&wt=javabin} {add=[47 (1415531047389495296)]} 0 6
[junit4:junit4]   2> 5898 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[33 (-1415531047397883904)]} 0 0
[junit4:junit4]   2> 5908 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5910 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[33 (-1415531047405223936)]} 0 5
[junit4:junit4]   2> 5947 T973 C56 P39236 /update {version=2&wt=javabin} {add=[48 (1415531047413612544)]} 0 35
[junit4:junit4]   2> 5947 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10042 (1415531047309803520)]} 0 133
[junit4:junit4]   2> 5966 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5967 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10042 (1415531047452409857)]} 0 17
[junit4:junit4]   2> 5970 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10043 (1415531047472332800)]} 0 1
[junit4:junit4]   2> 5975 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5976 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10043 (1415531047475478528)]} 0 4
[junit4:junit4]   2> 5978 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10044 (1415531047481769984)]} 0 0
[junit4:junit4]   2> 6036 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=84 
[junit4:junit4]   2> 6036 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=54 
[junit4:junit4]   2> 6037 T989 C55 P35775 /update {version=2&wt=javabin} {add=[48 (1415531047452409856)]} 0 87
[junit4:junit4]   2> 6037 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10044 (1415531047483867136)]} 0 57
[junit4:junit4]   2> 6039 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[34 (-1415531047545733120)]} 0 0
[junit4:junit4]   2> 6040 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[10032 (-1415531047546781696)]} 0 1
[junit4:junit4]   2> 6042 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6043 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6043 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[10032 (-1415531047547830273)]} 0 2
[junit4:junit4]   2> 6043 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[34 (-1415531047547830272)]} 0 2
[junit4:junit4]   2> 6046 T972 C56 P39236 /update {version=2&wt=javabin} {add=[49 (1415531047553073153)]} 0 0
[junit4:junit4]   2> 6047 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10045 (1415531047553073152)]} 0 2
[junit4:junit4]   2> 6051 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6052 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10045 (1415531047556218880)]} 0 4
[junit4:junit4]   2> 6053 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6054 T989 C55 P35775 /update {version=2&wt=javabin} {add=[49 (1415531047558316032)]} 0 4
[junit4:junit4]   2> 6055 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10046 (1415531047561461760)]} 0 1
[junit4:junit4]   2> 6056 T973 C56 P39236 /update {version=2&wt=javabin} {add=[50 (1415531047563558912)]} 0 0
[junit4:junit4]   2> 6059 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6059 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10046 (1415531047564607488)]} 0 3
[junit4:junit4]   2> 6061 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6061 T988 C55 P35775 /update {version=2&wt=javabin} {add=[50 (1415531047565656064)]} 0 3
[junit4:junit4]   2> 6062 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10047 (1415531047569850368)]} 0 0
[junit4:junit4]   2> 6065 T972 C56 P39236 /update {version=2&wt=javabin} {add=[51 (1415531047571947520)]} 0 1
[junit4:junit4]   2> 6069 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6070 T989 C55 P35775 /update {version=2&wt=javabin} {add=[51 (1415531047575093248)]} 0 3
[junit4:junit4]   2> 6072 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[35 (-1415531047580336128)]} 0 1
[junit4:junit4]   2> 6074 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6075 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10047 (1415531047574044672)]} 0 10
[junit4:junit4]   2> 6076 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6076 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[35 (-1415531047582433280)]} 0 2
[junit4:junit4]   2> 6077 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[10033 (-1415531047585579008)]} 0 0
[junit4:junit4]   2> 6079 T972 C56 P39236 /update {version=2&wt=javabin} {add=[52 (1415531047587676160)]} 0 0
[junit4:junit4]   2> 6081 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6082 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10033 (-1415531047587676160)]} 0 3
[junit4:junit4]   2> 6084 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10048 (1415531047592919040)]} 0 0
[junit4:junit4]   2> 6084 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6086 T989 C55 P35775 /update {version=2&wt=javabin} {add=[52 (1415531047589773312)]} 0 5
[junit4:junit4]   2> 6089 T972 C56 P39236 /update {version=2&wt=javabin} {add=[53 (1415531047598161920)]} 0 0
[junit4:junit4]   2> 6095 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6095 T989 C55 P35775 /update {version=2&wt=javabin} {add=[53 (1415531047601307648)]} 0 4
[junit4:junit4]   2> 6097 T972 C56 P39236 /update {version=2&wt=javabin} {add=[54 (1415531047606550528)]} 0 0
[junit4:junit4]   2> 6098 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6098 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10048 (1415531047595016192)]} 0 12
[junit4:junit4]   2> 6100 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[10034 (-1415531047609696256)]} 0 0
[junit4:junit4]   2> 6101 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6102 T989 C55 P35775 /update {version=2&wt=javabin} {add=[54 (1415531047608647680)]} 0 3
[junit4:junit4]   2> 6104 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6109 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10034 (-1415531047611793408)]} 0 7
[junit4:junit4]   2> 6110 T972 C56 P39236 /update {version=2&wt=javabin} {add=[55 (1415531047613890560)]} 0 6
[junit4:junit4]   2> 6111 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10049 (1415531047621230592)]} 0 0
[junit4:junit4]   2> 6113 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6115 T988 C55 P35775 /update {version=2&wt=javabin} {add=[55 (1415531047621230592)]} 0 4
[junit4:junit4]   2> 6117 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[36 (-1415531047627522048)]} 0 0
[junit4:junit4]   2> 6117 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6118 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10049 (1415531047625424896)]} 0 3
[junit4:junit4]   2> 6120 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10050 (1415531047630667776)]} 0 0
[junit4:junit4]   2> 6121 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6122 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[36 (-1415531047629619200)]} 0 2
[junit4:junit4]   2> 6124 T973 C56 P39236 /update {version=2&wt=javabin} {add=[56 (1415531047633813504)]} 0 1
[junit4:junit4]   2> 6128 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6129 T988 C55 P35775 /update {version=2&wt=javabin} {add=[56 (1415531047636959232)]} 0 3
[junit4:junit4]   2> 6131 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=7 
[junit4:junit4]   2> 6132 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10050 (1415531047632764928)]} 0 10
[junit4:junit4]   2> 6132 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[37 (-1415531047643250688)]} 0 0
[junit4:junit4]   2> 6135 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10051 (1415531047645347840)]} 0 1
[junit4:junit4]   2> 6136 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6136 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[37 (-1415531047645347840)]} 0 2
[junit4:junit4]   2> 6138 T972 C56 P39236 /update {version=2&wt=javabin} {add=[57 (1415531047649542144)]} 0 0
[junit4:junit4]   2> 6144 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6144 T989 C55 P35775 /update {version=2&wt=javabin} {add=[57 (1415531047652687872)]} 0 3
[junit4:junit4]   2> 6147 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6148 T972 C56 P39236 /update {version=2&wt=javabin} {add=[58 (1415531047658979328)]} 0 1
[junit4:junit4]   2> 6148 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10051 (1415531047648493568)]} 0 11
[junit4:junit4]   2> 6151 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[10035 (-1415531047662125056)]} 0 1
[junit4:junit4]   2> 6152 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6153 T989 C55 P35775 /update {version=2&wt=javabin} {add=[58 (1415531047662125056)]} 0 3
[junit4:junit4]   2> 6155 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6155 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10035 (-1415531047665270784)]} 0 2
[junit4:junit4]   2> 6158 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10052 (1415531047669465088)]} 0 1
[junit4:junit4]   2> 6158 T973 C56 P39236 /update {version=2&wt=javabin} {add=[59 (1415531047670513664)]} 0 0
[junit4:junit4]   2> 6164 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6165 T988 C55 P35775 /update {version=2&wt=javabin} {add=[59 (1415531047672610817)]} 0 5
[junit4:junit4]   2> 6167 T973 C56 P39236 /update {version=2&wt=javabin} {add=[60 (1415531047679950848)]} 0 0
[junit4:junit4]   2> 6170 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6171 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6172 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10052 (1415531047672610816)]} 0 12
[junit4:junit4]   2> 6172 T988 C55 P35775 /update {version=2&wt=javabin} {add=[60 (1415531047682048000)]} 0 3
[junit4:junit4]   2> 6174 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10053 (1415531047687290880)]} 0 1
[junit4:junit4]   2> 6174 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[38 (-1415531047687290881)]} 0 0
[junit4:junit4]   2> 6178 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6179 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6182 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10053 (1415531047689388032)]} 0 6
[junit4:junit4]   2> 6183 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[38 (-1415531047689388033)]} 0 7
[junit4:junit4]   2> 6185 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10054 (1415531047698825217)]} 0 0
[junit4:junit4]   2> 6192 T973 C56 P39236 /update {version=2&wt=javabin} {add=[61 (1415531047698825216)]} 0 8
[junit4:junit4]   2> 6193 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6193 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10054 (1415531047701970944)]} 0 6
[junit4:junit4]   2> 6196 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6196 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10055 (1415531047709310976)]} 0 1
[junit4:junit4]   2> 6197 T988 C55 P35775 /update {version=2&wt=javabin} {add=[61 (1415531047708262400)]} 0 3
[junit4:junit4]   2> 6198 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[39 (-1415531047712456704)]} 0 0
[junit4:junit4]   2> 6201 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6201 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10055 (1415531047712456704)]} 0 3
[junit4:junit4]   2> 6202 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6203 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[10036 (-1415531047717699584)]} 0 0
[junit4:junit4]   2> 6203 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[39 (-1415531047714553856)]} 0 3
[junit4:junit4]   2> 6205 T973 C56 P39236 /update {version=2&wt=javabin} {add=[62 (1415531047719796736)]} 0 0
[junit4:junit4]   2> 6206 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6207 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[10036 (-1415531047719796736)]} 0 3
[junit4:junit4]   2> 6209 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6209 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10056 (1415531047723991040)]} 0 0
[junit4:junit4]   2> 6210 T988 C55 P35775 /update {version=2&wt=javabin} {add=[62 (1415531047721893888)]} 0 3
[junit4:junit4]   2> 6217 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[41 (-1415531047732379648)]} 0 0
[junit4:junit4]   2> 6222 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6222 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[41 (-1415531047734476800)]} 0 3
[junit4:junit4]   2> 6223 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=9 
[junit4:junit4]   2> 6223 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10056 (1415531047727136768)]} 0 11
[junit4:junit4]   2> 6225 T973 C56 P39236 /update {version=2&wt=javabin} {add=[63 (1415531047740768256)]} 0 1
[junit4:junit4]   2> 6225 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[10037 (-1415531047740768257)]} 0 0
[junit4:junit4]   2> 6229 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6230 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6230 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10037 (-1415531047742865409)]} 0 3
[junit4:junit4]   2> 6230 T989 C55 P35775 /update {version=2&wt=javabin} {add=[63 (1415531047742865408)]} 0 3
[junit4:junit4]   2> 6232 T973 C56 P39236 /update {version=2&wt=javabin} {add=[64 (1415531047748108289)]} 0 0
[junit4:junit4]   2> 6232 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10057 (1415531047748108288)]} 0 0
[junit4:junit4]   2> 6238 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6239 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10057 (1415531047751254017)]} 0 5
[junit4:junit4]   2> 6242 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10058 (1415531047758594048)]} 0 0
[junit4:junit4]   2> 6243 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6243 T989 C55 P35775 /update {version=2&wt=javabin} {add=[64 (1415531047751254016)]} 0 9
[junit4:junit4]   2> 6245 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[42 (-1415531047761739776)]} 0 0
[junit4:junit4]   2> 6250 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6250 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[42 (-1415531047763836928)]} 0 3
[junit4:junit4]   2> 6253 T972 C56 P39236 /update {version=2&wt=javabin} {add=[65 (1415531047769079808)]} 0 1
[junit4:junit4]   2> 6253 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=7 
[junit4:junit4]   2> 6253 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10058 (1415531047760691200)]} 0 9
[junit4:junit4]   2> 6255 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10059 (1415531047772225536)]} 0 0
[junit4:junit4]   2> 6257 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6258 T989 C55 P35775 /update {version=2&wt=javabin} {add=[65 (1415531047772225536)]} 0 3
[junit4:junit4]   2> 6260 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6260 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[45 (-1415531047777468416)]} 0 0
[junit4:junit4]   2> 6260 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10059 (1415531047775371264)]} 0 2
[junit4:junit4]   2> 6263 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6264 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[45 (-1415531047779565568)]} 0 2
[junit4:junit4]   2> 6266 T973 C56 P39236 /update {version=2&wt=javabin} {add=[66 (1415531047783759872)]} 0 0
[junit4:junit4]   2> 6269 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10060 (1415531047779565568)]} 0 7
[junit4:junit4]   2> 6270 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6271 T989 C55 P35775 /update {version=2&wt=javabin} {add=[66 (1415531047785857024)]} 0 3
[junit4:junit4]   2> 6273 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6273 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10060 (1415531047787954176)]} 0 3
[junit4:junit4]   2> 6274 T972 C56 P39236 /update {version=2&wt=javabin} {add=[67 (1415531047790051328)]} 0 2
[junit4:junit4]   2> 6276 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[10038 (-1415531047793197056)]} 0 1
[junit4:junit4]   2> 6279 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6280 T988 C55 P35775 /update {version=2&wt=javabin} {add=[67 (1415531047793197056)]} 0 5
[junit4:junit4]   2> 6280 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6281 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[10038 (-1415531047797391360)]} 0 3
[junit4:junit4]   2> 6282 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[47 (-1415531047800537088)]} 0 1
[junit4:junit4]   2> 6283 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10061 (1415531047801585664)]} 0 0
[junit4:junit4]   2> 6285 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6286 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[47 (-1415531047801585664)]} 0 3
[junit4:junit4]   2> 6288 T972 C56 P39236 /update {version=2&wt=javabin} {add=[68 (1415531047805779968)]} 0 1
[junit4:junit4]   2> 6288 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6288 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10061 (1415531047803682816)]} 0 3
[junit4:junit4]   2> 6290 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[10039 (-1415531047808925696)]} 0 0
[junit4:junit4]   2> 6292 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6293 T989 C55 P35775 /update {version=2&wt=javabin} {add=[68 (1415531047808925696)]} 0 3
[junit4:junit4]   2> 6294 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6294 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10039 (-1415531047811022848)]} 0 2
[junit4:junit4]   2> 6295 T972 C56 P39236 /update {version=2&wt=javabin} {add=[69 (1415531047814168576)]} 0 0
[junit4:junit4]   2> 6297 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10062 (1415531047815217152)]} 0 1
[junit4:junit4]   2> 6302 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6303 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10062 (1415531047818362880)]} 0 4
[junit4:junit4]   2> 6305 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6305 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[10041 (-1415531047824654336)]} 0 0
[junit4:junit4]   2> 6305 T988 C55 P35775 /update {version=2&wt=javabin} {add=[69 (1415531047816265728)]} 0 8
[junit4:junit4]   2> 6307 T973 C56 P39236 /update {version=2&wt=javabin} {add=[70 (1415531047826751488)]} 0 0
[junit4:junit4]   2> 6308 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6309 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[10041 (-1415531047826751488)]} 0 2
[junit4:junit4]   2> 6311 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6311 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10063 (1415531047829897216)]} 0 1
[junit4:junit4]   2> 6312 T988 C55 P35775 /update {version=2&wt=javabin} {add=[70 (1415531047828848640)]} 0 3
[junit4:junit4]   2> 6315 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6316 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10063 (1415531047833042944)]} 0 3
[junit4:junit4]   2> 6319 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10064 (1415531047838285824)]} 0 1
[junit4:junit4]   2> 6320 T973 C56 P39236 /update {version=2&wt=javabin} {add=[71 (1415531047833042944)]} 0 7
[junit4:junit4]   2> 6324 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6325 T988 C55 P35775 /update {version=2&wt=javabin} {add=[71 (1415531047842480128)]} 0 3
[junit4:junit4]   2> 6327 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[48 (-1415531047847723008)]} 0 0
[junit4:junit4]   2> 6329 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=7 
[junit4:junit4]   2> 6330 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10064 (1415531047841431552)]} 0 9
[junit4:junit4]   2> 6331 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6331 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[48 (-1415531047849820160)]} 0 2
[junit4:junit4]   2> 6331 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[10042 (-1415531047851917312)]} 0 0
[junit4:junit4]   2> 6333 T972 C56 P39236 /update {version=2&wt=javabin} {add=[72 (1415531047854014464)]} 0 0
[junit4:junit4]   2> 6335 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6335 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10042 (-1415531047854014464)]} 0 2
[junit4:junit4]   2> 6337 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6337 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10065 (1415531047858208768)]} 0 0
[junit4:junit4]   2> 6338 T989 C55 P35775 /update {version=2&wt=javabin} {add=[72 (1415531047856111616)]} 0 3
[junit4:junit4]   2> 6340 T972 C56 P39236 /update {version=2&wt=javabin} {add=[73 (1415531047861354496)]} 0 0
[junit4:junit4]   2> 6342 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6342 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10065 (1415531047860305920)]} 0 3
[junit4:junit4]   2> 6344 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[10045 (-1415531047865548800)]} 0 0
[junit4:junit4]   2> 6344 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6345 T989 C55 P35775 /update {version=2&wt=javabin} {add=[73 (1415531047863451648)]} 0 3
[junit4:junit4]   2> 6347 T972 C56 P39236 /update {version=2&wt=javabin} {add=[74 (1415531047868694528)]} 0 0
[junit4:junit4]   2> 6348 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6349 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10045 (-1415531047867645952)]} 0 3
[junit4:junit4]   2> 6353 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6354 T989 C55 P35775 /update {version=2&wt=javabin} {add=[74 (1415531047870791680)]} 0 5
[junit4:junit4]   2> 6358 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10066 (1415531047872888832)]} 0 8
[junit4:junit4]   2> 6358 T973 C56 P39236 /update {version=2&wt=javabin} {add=[75 (1415531047879180288)]} 0 1
[junit4:junit4]   2> 6364 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6364 T988 C55 P35775 /update {version=2&wt=javabin} {add=[75 (1415531047882326017)]} 0 4
[junit4:junit4]   2> 6368 T973 C56 P39236 /update {version=2&wt=javabin} {add=[76 (1415531047889666048)]} 0 1
[junit4:junit4]   2> 6369 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6369 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10066 (1415531047882326016)]} 0 9
[junit4:junit4]   2> 6374 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10067 (1415531047893860352)]} 0 3
[junit4:junit4]   2> 6379 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 6379 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10067 (1415531047899103232)]} 0 3
[junit4:junit4]   2> 6379 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=8 
[junit4:junit4]   2> 6380 T988 C55 P35775 /update {version=2&wt=javabin} {add=[76 (1415531047892811776)]} 0 10
[junit4:junit4]   2> 6381 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[10047 (-1415531047904346112)]} 0 0
[junit4:junit4]   2> 6382 T972 C56 P39236 /update {version=2&wt=javabin} {add=[77 (1415531047904346113)]} 0 1
[junit4:junit4]   2> 6385 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6385 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10047 (-1415531047906443264)]} 0 2
[junit4:junit4]   2> 6386 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6386 T989 C55 P35775 /update {version=2&wt=javabin} {add=[77 (1415531047907491840)]} 0 2
[junit4:junit4]   2> 6387 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10068 (1415531047910637568)]} 0 0
[junit4:junit4]   2> 6388 T973 C56 P39236 /update {version=2&wt=javabin} {add=[78 (1415531047911686144)]} 0 0
[junit4:junit4]   2> 6391 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6391 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10068 (1415531047912734720)]} 0 2
[junit4:junit4]   2> 6393 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6393 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10069 (1415531047916929024)]} 0 0
[junit4:junit4]   2> 6394 T988 C55 P35775 /update {version=2&wt=javabin} {add=[78 (1415531047913783296)]} 0 4
[junit4:junit4]   2> 6396 T973 C56 P39236 /update {version=2&wt=javabin} {add=[79 (1415531047919026176)]} 0 1
[junit4:junit4]   2> 6397 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6398 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10069 (1415531047919026176)]} 0 3
[junit4:junit4]   2> 6400 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6400 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10070 (1415531047923220480)]} 0 1
[junit4:junit4]   2> 6400 T988 C55 P35775 /update {version=2&wt=javabin} {add=[79 (1415531047922171904)]} 0 2
[junit4:junit4]   2> 6402 T973 C56 P39236 /update {version=2&wt=javabin} {add=[80 (1415531047926366208)]} 0 0
[junit4:junit4]   2> 6403 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6404 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10070 (1415531047926366208)]} 0 3
[junit4:junit4]   2> 6406 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10071 (1415531047929511936)]} 0 1
[junit4:junit4]   2> 6410 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6411 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10071 (1415531047932657664)]} 0 3
[junit4:junit4]   2> 6412 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[10048 (-1415531047936851968)]} 0 0
[junit4:junit4]   2> 6418 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6419 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[10048 (-1415531047942094848)]} 0 3
[junit4:junit4]   2> 6460 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6460 T988 C55 P35775 /update {version=2&wt=javabin} {add=[80 (1415531047928463360)]} 0 56
[junit4:junit4]   2> 6463 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[49 (-1415531047990329344)]} 0 1
[junit4:junit4]   2> 6468 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6469 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[49 (-1415531047992426496)]} 0 4
[junit4:junit4]   2> 6471 T972 C56 P39236 /update {version=2&wt=javabin} {add=[81 (1415531047998717952)]} 0 0
[junit4:junit4]   2> 6481 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6482 T988 C55 P35775 /update {version=2&wt=javabin} {add=[81 (1415531048001863680)]} 0 8
[junit4:junit4]   2> 6484 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[50 (-1415531048012349440)]} 0 0
[junit4:junit4]   2> 6488 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6489 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[50 (-1415531048014446592)]} 0 3
[junit4:junit4]   2> 6491 T972 C56 P39236 /update {version=2&wt=javabin} {add=[82 (1415531048019689472)]} 0 0
[junit4:junit4]   2> 6496 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6496 T988 C55 P35775 /update {version=2&wt=javabin} {add=[82 (1415531048022835200)]} 0 3
[junit4:junit4]   2> 6500 T972 C56 P39236 /update {version=2&wt=javabin} {add=[83 (1415531048029126656)]} 0 0
[junit4:junit4]   2> 6505 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6506 T988 C55 P35775 /update {version=2&wt=javabin} {add=[83 (1415531048032272384)]} 0 3
[junit4:junit4]   2> 6507 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10072 (1415531047946289152)]} 0 86
[junit4:junit4]   2> 6509 T972 C56 P39236 /update {version=2&wt=javabin} {add=[84 (1415531048038563840)]} 0 1
[junit4:junit4]   2> 6514 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6514 T989 C55 P35775 /update {version=2&wt=javabin} {add=[84 (1415531048040660993)]} 0 3
[junit4:junit4]   2> 6518 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[52 (-1415531048048001024)]} 0 0
[junit4:junit4]   2> 6524 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6525 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[52 (-1415531048052195328)]} 0 4
[junit4:junit4]   2> 6528 T972 C56 P39236 /update {version=2&wt=javabin} {add=[85 (1415531048057438208)]} 0 1
[junit4:junit4]   2> 6533 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6534 T989 C55 P35775 /update {version=2&wt=javabin} {add=[85 (1415531048061632512)]} 0 3
[junit4:junit4]   2> 6536 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[53 (-1415531048066875392)]} 0 0
[junit4:junit4]   2> 6539 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6540 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[53 (-1415531048068972544)]} 0 2
[junit4:junit4]   2> 6542 T972 C56 P39236 /update {version=2&wt=javabin} {add=[86 (1415531048073166848)]} 0 0
[junit4:junit4]   2> 6547 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6548 T989 C55 P35775 /update {version=2&wt=javabin} {add=[86 (1415531048076312576)]} 0 3
[junit4:junit4]   2> 6550 T972 C56 P39236 /update {version=2&wt=javabin} {add=[87 (1415531048081555456)]} 0 0
[junit4:junit4]   2> 6555 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6555 T989 C55 P35775 /update {version=2&wt=javabin} {add=[87 (1415531048084701184)]} 0 3
[junit4:junit4]   2> 6558 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[54 (-1415531048089944064)]} 0 1
[junit4:junit4]   2> 6561 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6562 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[54 (-1415531048092041216)]} 0 2
[junit4:junit4]   2> 6587 T972 C56 P39236 /update {version=2&wt=javabin} {add=[88 (1415531048096235520)]} 0 23
[junit4:junit4]   2> 6597 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=84 
[junit4:junit4]   2> 6598 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10072 (1415531048040660992)]} 0 87
[junit4:junit4]   2> 6603 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10073 (1415531048136081408)]} 0 1
[junit4:junit4]   2> 6604 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6606 T989 C55 P35775 /update {version=2&wt=javabin} {add=[88 (1415531048124547072)]} 0 15
[junit4:junit4]   2> 6610 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[55 (-1415531048144470016)]} 0 0
[junit4:junit4]   2> 6611 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6612 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10073 (1415531048142372864)]} 0 4
[junit4:junit4]   2> 6614 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10074 (1415531048148664320)]} 0 0
[junit4:junit4]   2> 6615 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6616 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[55 (-1415531048147615744)]} 0 3
[junit4:junit4]   2> 6618 T972 C56 P39236 /update {version=2&wt=javabin} {add=[89 (1415531048152858624)]} 0 0
[junit4:junit4]   2> 6620 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6620 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10074 (1415531048151810048)]} 0 3
[junit4:junit4]   2> 6623 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6623 T989 C55 P35775 /update {version=2&wt=javabin} {add=[89 (1415531048154955776)]} 0 3
[junit4:junit4]   2> 6625 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10075 (1415531048159150080)]} 0 1
[junit4:junit4]   2> 6626 T973 C56 P39236 /update {version=2&wt=javabin} {add=[90 (1415531048160198656)]} 0 1
[junit4:junit4]   2> 6631 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6631 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10075 (1415531048162295808)]} 0 4
[junit4:junit4]   2> 6633 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6633 T988 C55 P35775 /update {version=2&wt=javabin} {add=[90 (1415531048165441536)]} 0 3
[junit4:junit4]   2> 6634 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10076 (1415531048168587264)]} 0 1
[junit4:junit4]   2> 6636 T972 C56 P39236 /update {version=2&wt=javabin} {add=[91 (1415531048170684416)]} 0 1
[junit4:junit4]   2> 6638 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6639 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10076 (1415531048171732992)]} 0 3
[junit4:junit4]   2> 6641 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10077 (1415531048176975872)]} 0 0
[junit4:junit4]   2> 6655 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6656 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10077 (1415531048188510208)]} 0 4
[junit4:junit4]   2> 6660 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10078 (1415531048196898816)]} 0 0
[junit4:junit4]   2> 6665 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6666 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10078 (1415531048200044544)]} 0 3
[junit4:junit4]   2> 6669 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10079 (1415531048206336000)]} 0 1
[junit4:junit4]   2> 6678 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=36 
[junit4:junit4]   2> 6678 T989 C55 P35775 /update {version=2&wt=javabin} {add=[91 (1415531048175927296)]} 0 38
[junit4:junit4]   2> 6683 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[61 (-1415531048221016064)]} 0 0
[junit4:junit4]   2> 6685 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6690 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6690 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[61 (-1415531048223113216)]} 0 5
[junit4:junit4]   2> 6686 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10079 (1415531048208433152)]} 0 15
[junit4:junit4]   2> 6693 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10080 (1415531048231501824)]} 0 0
[junit4:junit4]   2> 6694 T972 C56 P39236 /update {version=2&wt=javabin} {add=[92 (1415531048232550400)]} 0 1
[junit4:junit4]   2> 6699 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6700 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6700 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10080 (1415531048235696128)]} 0 3
[junit4:junit4]   2> 6700 T989 C55 P35775 /update {version=2&wt=javabin} {add=[92 (1415531048234647552)]} 0 4
[junit4:junit4]   2> 6703 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[10049 (-1415531048241987584)]} 0 0
[junit4:junit4]   2> 6710 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6711 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10049 (-1415531048244084736)]} 0 6
[junit4:junit4]   2> 6713 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10081 (1415531048252473344)]} 0 0
[junit4:junit4]   2> 6715 T972 C56 P39236 /update {version=2&wt=javabin} {add=[93 (1415531048243036160)]} 0 11
[junit4:junit4]   2> 6720 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6721 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6724 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10081 (1415531048254570496)]} 0 9
[junit4:junit4]   2> 6724 T989 C55 P35775 /update {version=2&wt=javabin} {add=[93 (1415531048256667648)]} 0 7
[junit4:junit4]   2> 6726 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[62 (-1415531048266104832)]} 0 0
[junit4:junit4]   2> 6727 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[10050 (-1415531048267153408)]} 0 0
[junit4:junit4]   2> 6730 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6731 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[62 (-1415531048268201984)]} 0 3
[junit4:junit4]   2> 6731 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6732 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10050 (-1415531048269250560)]} 0 3
[junit4:junit4]   2> 6734 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10082 (1415531048274493440)]} 0 0
[junit4:junit4]   2> 6736 T972 C56 P39236 /update {version=2&wt=javabin} {add=[94 (1415531048273444864)]} 0 3
[junit4:junit4]   2> 6739 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6740 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10082 (1415531048276590592)]} 0 4
[junit4:junit4]   2> 6742 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10083 (1415531048282882048)]} 0 0
[junit4:junit4]   2> 6746 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6747 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10083 (1415531048284979200)]} 0 3
[junit4:junit4]   2> 6749 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10084 (1415531048289173504)]} 0 1
[junit4:junit4]   2> 6750 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=9 
[junit4:junit4]   2> 6750 T989 C55 P35775 /update {version=2&wt=javabin} {add=[94 (1415531048278687744)]} 0 12
[junit4:junit4]   2> 6752 T972 C56 P39236 /update {version=2&wt=javabin} {add=[95 (1415531048293367808)]} 0 0
[junit4:junit4]   2> 6754 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6755 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10084 (1415531048292319232)]} 0 4
[junit4:junit4]   2> 6756 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6756 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[10052 (-1415531048297562112)]} 0 0
[junit4:junit4]   2> 6757 T989 C55 P35775 /update {version=2&wt=javabin} {add=[95 (1415531048295464960)]} 0 3
[junit4:junit4]   2> 6760 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[63 (-1415531048301756416)]} 0 0
[junit4:junit4]   2> 6761 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6761 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10052 (-1415531048300707840)]} 0 2
[junit4:junit4]   2> 6763 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10085 (1415531048304902144)]} 0 0
[junit4:junit4]   2> 6764 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6765 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[63 (-1415531048304902144)]} 0 3
[junit4:junit4]   2> 6770 T972 C56 P39236 /update {version=2&wt=javabin} {add=[96 (1415531048312242176)]} 0 0
[junit4:junit4]   2> 6775 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6775 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6775 T989 C55 P35775 /update {version=2&wt=javabin} {add=[96 (1415531048314339328)]} 0 3
[junit4:junit4]   2> 6776 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10085 (1415531048306999296)]} 0 11
[junit4:junit4]   2> 6778 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[10053 (-1415531048320630785)]} 0 0
[junit4:junit4]   2> 6778 T972 C56 P39236 /update {version=2&wt=javabin} {add=[97 (1415531048320630784)]} 0 1
[junit4:junit4]   2> 6782 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6786 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6789 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10053 (-1415531048322727936)]} 0 9
[junit4:junit4]   2> 6790 T989 C55 P35775 /update {version=2&wt=javabin} {add=[97 (1415531048326922240)]} 0 7
[junit4:junit4]   2> 6792 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[64 (-1415531048335310849)]} 0 0
[junit4:junit4]   2> 6792 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10086 (1415531048335310848)]} 0 0
[junit4:junit4]   2> 6796 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6796 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6797 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10086 (1415531048337408001)]} 0 3
[junit4:junit4]   2> 6797 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[64 (-1415531048337408000)]} 0 3
[junit4:junit4]   2> 6799 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10087 (1415531048341602304)]} 0 1
[junit4:junit4]   2> 6799 T973 C56 P39236 /update {version=2&wt=javabin} {add=[98 (1415531048342650880)]} 0 1
[junit4:junit4]   2> 6806 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6806 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6807 T988 C55 P35775 /update {version=2&wt=javabin} {add=[98 (1415531048347893760)]} 0 3
[junit4:junit4]   2> 6807 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10087 (1415531048347893761)]} 0 3
[junit4:junit4]   2> 6809 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[10054 (-1415531048353136640)]} 0 1
[junit4:junit4]   2> 6809 T973 C56 P39236 /update {version=2&wt=javabin} {add=[99 (1415531048353136641)]} 0 1
[junit4:junit4]   2> 6812 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6813 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6813 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[10054 (-1415531048355233792)]} 0 2
[junit4:junit4]   2> 6814 T988 C55 P35775 /update {version=2&wt=javabin} {add=[99 (1415531048355233793)]} 0 3
[junit4:junit4]   2> 6815 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[68 (-1415531048359428097)]} 0 0
[junit4:junit4]   2> 6815 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10088 (1415531048359428096)]} 0 0
[junit4:junit4]   2> 6820 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6820 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6820 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[68 (-1415531048362573824)]} 0 2
[junit4:junit4]   2> 6820 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10088 (1415531048362573825)]} 0 2
[junit4:junit4]   2> 6822 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[10055 (-1415531048366768128)]} 0 0
[junit4:junit4]   2> 6822 T973 C56 P39236 /update {version=2&wt=javabin} {add=[100 (1415531048366768129)]} 0 0
[junit4:junit4]   2> 6826 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6826 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6826 T988 C55 P35775 /update {version=2&wt=javabin} {add=[100 (1415531048368865281)]} 0 2
[junit4:junit4]   2> 6826 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[10055 (-1415531048368865280)]} 0 2
[junit4:junit4]   2> 6837 T973 C56 P39236 /update {version=2&wt=javabin} {add=[101 (1415531048373059584)]} 0 9
[junit4:junit4]   2> 6838 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10089 (1415531048375156736)]} 0 8
[junit4:junit4]   2> 6841 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6842 T989 C55 P35775 /update {version=2&wt=javabin} {add=[101 (1415531048384593920)]} 0 3
[junit4:junit4]   2> 6844 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[70 (-1415531048389836800)]} 0 0
[junit4:junit4]   2> 6848 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6848 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6849 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10089 (1415531048385642496)]} 0 9
[junit4:junit4]   2> 6849 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[70 (-1415531048392982528)]} 0 2
[junit4:junit4]   2> 6856 T973 C56 P39236 /update {version=2&wt=javabin} {add=[102 (1415531048401371136)]} 0 6
[junit4:junit4]   2> 6856 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10090 (1415531048401371137)]} 0 6
[junit4:junit4]   2> 6868 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=7 
[junit4:junit4]   2> 6869 T989 C55 P35775 /update {version=2&wt=javabin} {add=[102 (1415531048405565440)]} 0 10
[junit4:junit4]   2> 6871 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[73 (-1415531048418148352)]} 0 0
[junit4:junit4]   2> 6873 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=12 
[junit4:junit4]   2> 6873 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10090 (1415531048405565441)]} 0 14
[junit4:junit4]   2> 6875 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6876 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10091 (1415531048422342656)]} 0 1
[junit4:junit4]   2> 6876 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[73 (-1415531048420245504)]} 0 3
[junit4:junit4]   2> 6881 T972 C56 P39236 /update {version=2&wt=javabin} {add=[103 (1415531048428634112)]} 0 1
[junit4:junit4]   2> 6883 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6883 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10091 (1415531048427585536)]} 0 3
[junit4:junit4]   2> 6885 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[10061 (-1415531048432828416)]} 0 0
[junit4:junit4]   2> 6887 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6888 T988 C55 P35775 /update {version=2&wt=javabin} {add=[103 (1415531048430731264)]} 0 5
[junit4:junit4]   2> 6889 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6889 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[10061 (-1415531048434925568)]} 0 2
[junit4:junit4]   2> 6891 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[80 (-1415531048439119872)]} 0 0
[junit4:junit4]   2> 6892 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10092 (1415531048440168448)]} 0 0
[junit4:junit4]   2> 6895 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6896 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[80 (-1415531048441217024)]} 0 3
[junit4:junit4]   2> 6896 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6897 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10092 (1415531048442265600)]} 0 3
[junit4:junit4]   2> 6898 T973 C56 P39236 /update {version=2&wt=javabin} {add=[104 (1415531048446459904)]} 0 0
[junit4:junit4]   2> 6899 T972 C56 P39236 /update {version=2&wt=javabin} {add=[10093 (1415531048447508480)]} 0 0
[junit4:junit4]   2> 6902 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6903 T988 C55 P35775 /update {version=2&wt=javabin} {add=[104 (1415531048448557056)]} 0 3
[junit4:junit4]   2> 6904 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6905 T989 C55 P35775 /update {version=2&wt=javabin} {add=[10093 (1415531048449605632)]} 0 4
[junit4:junit4]   2> 6907 T973 C56 P39236 /update {version=2&wt=javabin} {delete=[10062 (-1415531048455897088)]} 0 0
[junit4:junit4]   2> 6907 T972 C56 P39236 /update {version=2&wt=javabin} {add=[105 (1415531048455897089)]} 0 0
[junit4:junit4]   2> 6911 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6911 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6912 T988 C55 P35775 /update {version=2&wt=javabin} {delete=[10062 (-1415531048457994240)]} 0 3
[junit4:junit4]   2> 6912 T989 C55 P35775 /update {version=2&wt=javabin} {add=[105 (1415531048459042816)]} 0 3
[junit4:junit4]   2> 6914 T972 C56 P39236 /update {version=2&wt=javabin} {delete=[83 (-1415531048463237121)]} 0 0
[junit4:junit4]   2> 6915 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10094 (1415531048463237120)]} 0 1
[junit4:junit4]   2> 6919 T999 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 6920 T988 C55 P35775 /update {version=2&wt=javabin} {add=[10094 (1415531048466382848)]} 0 3
[junit4:junit4]   2> 6920 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1:35775/solr/collection1/&update.distrib=FROMLEADER&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 6920 T989 C55 P35775 /update {version=2&wt=javabin} {delete=[83 (-1415531048466382849)]} 0 3
[junit4:junit4]   2> 6922 T973 C56 P39236 /update {version=2&wt=javabin} {add=[10095 (1415531048471625728)]} 0 0
[junit4:junit4]   2> 6922 T972 C56 P39236 /update {version=2&wt=javabin} {add=[106 (1415531048471625729)]} 0 0
[junit4:junit4]   2> 6931 T998 C54 P59957 REQ /update {version=2&distrib.from=http://127.0.0.1

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

4:junit4]   2> 24984 T960 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1621987452
[junit4:junit4]   2> 25669 T1114 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost.localdomain/127.0.0.1:47481
[junit4:junit4]   2> 25770 T1115 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 25770 T960 oaz.ZooKeeper.close Session: 0x13a4f9fb70a0007 closed
[junit4:junit4]   2> 25771 T960 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 25872 T960 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=RecoveryZkTest -Dtests.method=testDistribSearch -Dtests.seed=7A54949A9D476414 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=es_BO -Dtests.timezone=Australia/Sydney -Dtests.file.encoding=UTF-8
[junit4:junit4] ERROR   25.9s J0 | RecoveryZkTest.testDistribSearch <<<
[junit4:junit4]    > Throwable #1: org.apache.solr.common.SolrException: Server at http://127.0.0.1:59957/solr/collection1 returned non ok status:404, message:Can not find: /solr/collection1/select
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([7A54949A9D476414:FBB21A82EA180428]:0)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:374)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:181)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:90)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:301)
[junit4:junit4]    > 	at org.apache.solr.cloud.RecoveryZkTest.doTest(RecoveryZkTest.java:92)
[junit4:junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:695)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
[junit4:junit4]    > 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4:junit4]    > 	at java.lang.reflect.Method.invoke(Method.java:474)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 25881 T960 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4]   2> NOTE: test params are: codec=Lucene40: {intDefault=Pulsing40(freqCutoff=20 minBlockSize=11 maxBlockSize=108), rnd_b=PostingsFormat(name=Direct), id=PostingsFormat(name=Direct), range_facet_sl=PostingsFormat(name=Direct), other_tl1=Pulsing40(freqCutoff=20 minBlockSize=11 maxBlockSize=108), _version_=Pulsing40(freqCutoff=20 minBlockSize=11 maxBlockSize=108), range_facet_l=PostingsFormat(name=Lucene40WithOrds), a_si=Pulsing40(freqCutoff=20 minBlockSize=11 maxBlockSize=108), multiDefault=PostingsFormat(name=Lucene40WithOrds), timestamp=PostingsFormat(name=Lucene40WithOrds), range_facet_si=PostingsFormat(name=Lucene40WithOrds), a_t=PostingsFormat(name=Lucene40WithOrds), text=Lucene40(minBlockSize=11 maxBlockSize=108)}, sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=es_BO, timezone=Australia/Sydney
[junit4:junit4]   2> NOTE: Linux 3.2.0-31-generic amd64/Oracle Corporation 1.8.0-ea (64-bit)/cpus=8,threads=1,free=148652528,total=325255168
[junit4:junit4]   2> NOTE: All tests run in this JVM: [TestQuerySenderNoQuery, BasicDistributedZk2Test, AutoCommitTest, DateMathParserTest, UpdateRequestProcessorFactoryTest, TestQueryTypes, TestIBSimilarityFactory, SpatialFilterTest, TestWordDelimiterFilterFactory, DirectUpdateHandlerOptimizeTest, TestStressReorder, HighlighterConfigTest, TestSolrQueryParser, LoggingHandlerTest, ResourceLoaderTest, TestSearchPerf, AnalysisAfterCoreReloadTest, TermsComponentTest, PreAnalyzedFieldTest, SortByFunctionTest, DistanceFunctionTest, IndexBasedSpellCheckerTest, TestFastWriter, SOLR749Test, TestConfig, QueryElevationComponentTest, DefaultValueUpdateProcessorTest, UniqFieldsUpdateProcessorFactoryTest, TestNumberUtils, MBeansHandlerTest, CacheHeaderTest, TestFastLRUCache, DateFieldTest, TestLFUCache, NumericFieldsTest, JSONWriterTest, TestSolr4Spatial, TestRangeQuery, TestCollationField, TestSuggestSpellingConverter, FastVectorHighlighterTest, SampleTest, TestJoin, TestPseudoReturnFields, TestXIncludeConfig, SpellCheckComponentTest, CoreContainerCoreInitFailuresTest, TestRandomFaceting, TestLuceneMatchVersion, TestDefaultSimilarityFactory, TestSystemIdResolver, SyncSliceTest, TestIndexSearcher, CopyFieldTest, NoCacheHeaderTest, RecoveryZkTest]
[junit4:junit4] Completed on J0 in 25.90s, 1 test, 1 error <<< FAILURES!

[...truncated 354 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:38: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:180: 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:1143: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:816: There were test failures: 231 suites, 960 tests, 1 error, 7 ignored (2 assumptions)

Total time: 21 minutes 57 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