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-trunk-Linux (32bit/jdk1.6.0_35) - Build # 1212 - Failure!
Date Wed, 19 Sep 2012 03:58:15 GMT
Build: http://jenkins.sd-datasolutions.de/job/Lucene-Solr-trunk-Linux/1212/
Java: 32bit/jdk1.6.0_35 -client -XX:+UseConcMarkSweepGC

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

Error Message:
Server at http://127.0.0.1:47109/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:47109/solr/collection1 returned non ok status:404, message:Can not find: /solr/collection1/select
	at __randomizedtesting.SeedInfo.seed([E1B392627CF62553:60551C7A0BA9456F]:0)
	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:373)
	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:182)
	at org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:90)
	at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:324)
	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:39)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	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:662)




Build Log:
[...truncated 7217 lines...]
[junit4:junit4] Suite: org.apache.solr.cloud.RecoveryZkTest
[junit4:junit4]   2> 3 T778 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4:junit4]   2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./solrtest-RecoveryZkTest-1348026724206
[junit4:junit4]   2> 3 T778 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4]   2> 4 T779 oazs.ZooKeeperServer.setTickTime tickTime set to 1000
[junit4:junit4]   2> 5 T779 oazs.NIOServerCnxn$Factory.<init> binding to port 0.0.0.0/0.0.0.0:0
[junit4:junit4]   2> 9 T779 oazsp.FileTxnSnapLog.save Snapshotting: 0
[junit4:junit4]   2> 104 T778 oasc.ZkTestServer.run start zk server on port:47930
[junit4:junit4]   2> 104 T778 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47930 sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@a123fb
[junit4:junit4]   2> 105 T784 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47930
[junit4:junit4]   2> 105 T778 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 106 T784 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47930, initiating session
[junit4:junit4]   2> 106 T780 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:34508
[junit4:junit4]   2> 106 T780 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:34508
[junit4:junit4]   2> 106 T782 oazsp.FileTxnLog.append Creating new log file: log.1
[junit4:junit4]   2> 209 T782 oazs.NIOServerCnxn.finishSessionInit Established session 0x139dca76f750000 with negotiated timeout 10000 for client /127.0.0.1:34508
[junit4:junit4]   2> 209 T784 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47930, sessionid = 0x139dca76f750000, negotiated timeout = 10000
[junit4:junit4]   2> 209 T785 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@a123fb name:ZooKeeperConnection Watcher:127.0.0.1:47930 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 209 T778 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 210 T778 oascc.SolrZkClient.makePath makePath: /solr
[junit4:junit4]   2> 212 T783 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x139dca76f750000
[junit4:junit4]   2> 212 T785 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 212 T778 oaz.ZooKeeper.close Session: 0x139dca76f750000 closed
[junit4:junit4]   2> 213 T780 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:34508 which had sessionid 0x139dca76f750000
[junit4:junit4]   2> 213 T778 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47930/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@76975
[junit4:junit4]   2> 214 T786 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47930
[junit4:junit4]   2> 214 T778 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 214 T780 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:34509
[junit4:junit4]   2> 214 T786 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47930, initiating session
[junit4:junit4]   2> 215 T780 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:34509
[junit4:junit4]   2> 215 T782 oazs.NIOServerCnxn.finishSessionInit Established session 0x139dca76f750001 with negotiated timeout 10000 for client /127.0.0.1:34509
[junit4:junit4]   2> 215 T786 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47930, sessionid = 0x139dca76f750001, negotiated timeout = 10000
[junit4:junit4]   2> 216 T787 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@76975 name:ZooKeeperConnection Watcher:127.0.0.1:47930/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 216 T778 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 216 T778 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4:junit4]   2> 218 T778 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4:junit4]   2> 221 T778 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4:junit4]   2> 222 T778 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4:junit4]   2> 223 T778 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 224 T778 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 227 T778 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4:junit4]   2> 227 T778 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4:junit4]   2> 229 T778 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 230 T778 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 231 T778 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4:junit4]   2> 232 T778 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
[junit4:junit4]   2> 233 T778 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4:junit4]   2> 234 T778 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
[junit4:junit4]   2> 235 T778 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4:junit4]   2> 236 T778 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
[junit4:junit4]   2> 237 T778 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 237 T778 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 239 T778 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 239 T778 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 241 T778 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 242 T778 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 243 T778 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4:junit4]   2> 243 T778 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
[junit4:junit4]   2> 245 T783 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x139dca76f750001
[junit4:junit4]   2> 245 T787 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 245 T780 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:34509 which had sessionid 0x139dca76f750001
[junit4:junit4]   2> 245 T778 oaz.ZooKeeper.close Session: 0x139dca76f750001 closed
[junit4:junit4]   2> 246 T778 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 248 T778 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:58159
[junit4:junit4]   2> 249 T778 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 249 T778 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 249 T778 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 262 T778 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 262 T778 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 263 T778 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 263 T778 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 263 T778 oasc.CoreContainer.<init> New CoreContainer 9785203
[junit4:junit4]   2> 264 T778 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 264 T778 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 287 T778 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 297 T778 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:47930/solr
[junit4:junit4]   2> 298 T778 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47930/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@1e6ed16
[junit4:junit4]   2> 299 T797 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47930
[junit4:junit4]   2> 299 T778 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 299 T797 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47930, initiating session
[junit4:junit4]   2> 299 T780 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:34510
[junit4:junit4]   2> 300 T780 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:34510
[junit4:junit4]   2> 301 T782 oazs.NIOServerCnxn.finishSessionInit Established session 0x139dca76f750002 with negotiated timeout 5000 for client /127.0.0.1:34510
[junit4:junit4]   2> 301 T797 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47930, sessionid = 0x139dca76f750002, negotiated timeout = 5000
[junit4:junit4]   2> 301 T798 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1e6ed16 name:ZooKeeperConnection Watcher:127.0.0.1:47930/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 301 T778 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 302 T783 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139dca76f750002 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 303 T778 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4:junit4]   2> 304 T778 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:58159_solr
[junit4:junit4]   2> 305 T783 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139dca76f750002 type:delete cxid:0x7 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:58159_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:58159_solr
[junit4:junit4]   2> 305 T778 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:58159_solr
[junit4:junit4]   2> 307 T778 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 307 T778 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 307 T778 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 308 T778 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 308 T778 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 308 T778 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 309 T778 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 309 T778 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 309 T778 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 310 T778 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 313 T778 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4:junit4]   2> 315 T783 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139dca76f750002 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> 316 T778 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4]   2> 317 T778 oasc.Overseer.start Overseer (id=88344279398023170-127.0.0.1:58159_solr-n_0000000000) starting
[junit4:junit4]   2> 317 T783 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139dca76f750002 type:create cxid:0x1a zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 318 T783 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139dca76f750002 type:create cxid:0x1b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 318 T783 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139dca76f750002 type:create cxid:0x1c zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 319 T783 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139dca76f750002 type:create cxid:0x1d zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 320 T800 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
[junit4:junit4]   2> 320 T778 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4:junit4]   2> 322 T778 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 323 T799 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4]   2> 326 T778 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 327 T778 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection
[junit4:junit4]   2> 327 T778 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 328 T778 oasc.ZkController.readConfigName Load collection config from:/collections/control_collection
[junit4:junit4]   2> 328 T778 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 329 T778 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 329 T778 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 365 T778 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 423 T778 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 424 T778 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 428 T778 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 919 T778 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 926 T778 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 930 T778 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 938 T778 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 945 T778 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 948 T778 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 950 T778 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 951 T778 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1348026724206/control/data/
[junit4:junit4]   2> 951 T778 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1b6235b
[junit4:junit4]   2> 959 T778 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1348026724206/control/data/index/
[junit4:junit4]   2> 960 T778 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1348026724206/control/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 960 T778 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-1348026724206/control/data/index forceNew:false
[junit4:junit4]   2> 963 T778 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1348026724206/control/data/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 964 T778 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 964 T778 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 966 T778 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 966 T778 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 967 T778 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 967 T778 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 968 T778 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 968 T778 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 968 T778 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 969 T778 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 969 T778 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 970 T778 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 970 T778 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 971 T778 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 971 T778 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 972 T778 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 972 T778 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 973 T778 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 973 T778 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 973 T778 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 974 T778 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 974 T778 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 975 T778 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 975 T778 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 976 T778 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 976 T778 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 977 T778 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 978 T778 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 980 T778 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 981 T778 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SCHEMA.XML, OLD_SYNONYMS.TXT, STOPWORDS.TXT, PROTWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, SYNONYMS.TXT, CURRENCY.XML, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 983 T778 oass.SolrIndexSearcher.<init> Opening Searcher@174c252 main
[junit4:junit4]   2> 984 T778 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 984 T778 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 985 T778 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 991 T778 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 1010 T801 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@174c252 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 1016 T783 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139dca76f750002 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> 1017 T778 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 1018 T778 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:58159/solr shardId:control_shard
[junit4:junit4]   2> 1018 T778 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/control_shard/election
[junit4:junit4]   2> 1022 T783 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139dca76f750002 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> 1022 T778 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 1023 T783 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139dca76f750002 type:create cxid:0x63 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1327 T799 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 1328 T783 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139dca76f750002 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> 1332 T798 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 1524 T778 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4]   2> 1525 T778 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 1526 T778 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:58159/solr/collection1/
[junit4:junit4]   2> 1526 T778 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4:junit4]   2> 1527 T778 oasc.SyncStrategy.syncToMe http://127.0.0.1:58159/solr/collection1/ has no replicas
[junit4:junit4]   2> 1527 T778 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:58159/solr/collection1/
[junit4:junit4]   2> 1528 T778 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/control_shard
[junit4:junit4]   2> 1531 T783 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139dca76f750002 type:create cxid:0x88 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1836 T799 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 1841 T798 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 1884 T778 oasc.ZkController.register We are http://127.0.0.1:58159/solr/collection1/ and leader is http://127.0.0.1:58159/solr/collection1/
[junit4:junit4]   2> 1884 T778 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:58159/solr
[junit4:junit4]   2> 1885 T778 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4]   2> 1887 T778 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 1888 T778 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4:junit4]   2> 1888 T778 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 1888 T778 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 1947 T778 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 1949 T778 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:41562
[junit4:junit4]   2> 1949 T778 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 1950 T778 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./solrtest-jetty1-1348026726095
[junit4:junit4]   2> 1950 T778 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./solrtest-jetty1-1348026726095/'
[junit4:junit4]   2> 1965 T778 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 1965 T778 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 1965 T778 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./solrtest-jetty1-1348026726095
[junit4:junit4]   2> 1966 T778 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./solrtest-jetty1-1348026726095/solr.xml
[junit4:junit4]   2> 1966 T778 oasc.CoreContainer.<init> New CoreContainer 721145
[junit4:junit4]   2> 1966 T778 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./solrtest-jetty1-1348026726095/'
[junit4:junit4]   2> 1967 T778 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./solrtest-jetty1-1348026726095/'
[junit4:junit4]   2> 1980 T778 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 1993 T778 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:47930/solr
[junit4:junit4]   2> 1994 T778 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47930/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@aea1a2
[junit4:junit4]   2> 1995 T811 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47930
[junit4:junit4]   2> 1995 T778 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 1995 T811 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47930, initiating session
[junit4:junit4]   2> 1996 T780 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:34511
[junit4:junit4]   2> 1996 T780 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:34511
[junit4:junit4]   2> 1997 T811 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47930, sessionid = 0x139dca76f750003, negotiated timeout = 5000
[junit4:junit4]   2> 1997 T782 oazs.NIOServerCnxn.finishSessionInit Established session 0x139dca76f750003 with negotiated timeout 5000 for client /127.0.0.1:34511
[junit4:junit4]   2> 1997 T812 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@aea1a2 name:ZooKeeperConnection Watcher:127.0.0.1:47930/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 1997 T778 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 1998 T783 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139dca76f750003 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1999 T783 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139dca76f750003 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1999 T778 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41562_solr
[junit4:junit4]   2> 2000 T783 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139dca76f750003 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:41562_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:41562_solr
[junit4:junit4]   2> 2000 T778 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:41562_solr
[junit4:junit4]   2> 2002 T798 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 2002 T778 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 2003 T778 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 2003 T778 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 2004 T778 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 2004 T778 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 2005 T778 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 2005 T778 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 2006 T778 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 2006 T778 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 2007 T778 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 2012 T778 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 2016 T778 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./solrtest-jetty1-1348026726095/collection1
[junit4:junit4]   2> 2017 T778 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 2017 T778 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 2018 T778 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 2018 T778 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./solrtest-jetty1-1348026726095/collection1/'
[junit4:junit4]   2> 2019 T778 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/solrtest-jetty1-1348026726095/collection1/lib/README' to classloader
[junit4:junit4]   2> 2019 T778 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/solrtest-jetty1-1348026726095/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 2066 T778 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 2131 T778 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 2132 T778 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 2137 T778 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 2343 T799 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2345 T812 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 2345 T798 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 2650 T778 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 2660 T778 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 2663 T778 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 2670 T778 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 2674 T778 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 2677 T778 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 2678 T778 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 2679 T778 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./solrtest-jetty1-1348026726095/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1348026724206/jetty1/
[junit4:junit4]   2> 2680 T778 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1b6235b
[junit4:junit4]   2> 2680 T778 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1348026724206/jetty1/index/
[junit4:junit4]   2> 2681 T778 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1348026724206/jetty1/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 2681 T778 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-1348026724206/jetty1/index forceNew:false
[junit4:junit4]   2> 2685 T778 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1348026724206/jetty1/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 2685 T778 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 2686 T778 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 2687 T778 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 2688 T778 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 2688 T778 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 2689 T778 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 2689 T778 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 2690 T778 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 2690 T778 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 2691 T778 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 2691 T778 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 2692 T778 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 2693 T778 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 2693 T778 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 2694 T778 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 2694 T778 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 2695 T778 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 2695 T778 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 2696 T778 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2696 T778 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2697 T778 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2697 T778 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2698 T778 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2698 T778 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2699 T778 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2699 T778 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 2700 T778 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 2701 T778 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 2703 T778 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 2704 T778 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SCHEMA.XML, OLD_SYNONYMS.TXT, STOPWORDS.TXT, PROTWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, SYNONYMS.TXT, CURRENCY.XML, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 2706 T778 oass.SolrIndexSearcher.<init> Opening Searcher@f05ce2 main
[junit4:junit4]   2> 2707 T778 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 2707 T778 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 2708 T778 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 2711 T778 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 2730 T813 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@f05ce2 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 2847 T799 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2849 T798 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 2849 T812 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3235 T778 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 3236 T778 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:41562/solr shardId:shard1
[junit4:junit4]   2> 3237 T778 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election
[junit4:junit4]   2> 3241 T783 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139dca76f750003 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> 3242 T778 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 3242 T783 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139dca76f750003 type:create cxid:0x44 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3243 T778 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4]   2> 3244 T778 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 3244 T778 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:41562/solr/collection1/
[junit4:junit4]   2> 3244 T778 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4:junit4]   2> 3245 T778 oasc.SyncStrategy.syncToMe http://127.0.0.1:41562/solr/collection1/ has no replicas
[junit4:junit4]   2> 3245 T778 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:41562/solr/collection1/
[junit4:junit4]   2> 3245 T778 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4:junit4]   2> 3247 T783 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139dca76f750003 type:create cxid:0x4e zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3351 T799 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3355 T798 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3355 T812 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3398 T778 oasc.ZkController.register We are http://127.0.0.1:41562/solr/collection1/ and leader is http://127.0.0.1:41562/solr/collection1/
[junit4:junit4]   2> 3399 T778 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:41562/solr
[junit4:junit4]   2> 3400 T778 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4]   2> 3402 T778 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3404 T778 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4:junit4]   2> 3405 T778 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 3405 T778 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 3472 T778 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 3474 T778 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:47109
[junit4:junit4]   2> 3474 T778 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 3475 T778 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./solrtest-jetty2-1348026727616
[junit4:junit4]   2> 3475 T778 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./solrtest-jetty2-1348026727616/'
[junit4:junit4]   2> 3487 T778 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 3488 T778 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 3488 T778 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./solrtest-jetty2-1348026727616
[junit4:junit4]   2> 3488 T778 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./solrtest-jetty2-1348026727616/solr.xml
[junit4:junit4]   2> 3489 T778 oasc.CoreContainer.<init> New CoreContainer 15759798
[junit4:junit4]   2> 3489 T778 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./solrtest-jetty2-1348026727616/'
[junit4:junit4]   2> 3490 T778 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./solrtest-jetty2-1348026727616/'
[junit4:junit4]   2> 3503 T778 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 3517 T778 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:47930/solr
[junit4:junit4]   2> 3517 T778 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47930/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@1223ca6
[junit4:junit4]   2> 3518 T823 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47930
[junit4:junit4]   2> 3518 T778 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 3519 T823 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47930, initiating session
[junit4:junit4]   2> 3519 T780 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:34512
[junit4:junit4]   2> 3520 T780 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:34512
[junit4:junit4]   2> 3521 T782 oazs.NIOServerCnxn.finishSessionInit Established session 0x139dca76f750004 with negotiated timeout 5000 for client /127.0.0.1:34512
[junit4:junit4]   2> 3521 T823 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47930, sessionid = 0x139dca76f750004, negotiated timeout = 5000
[junit4:junit4]   2> 3521 T824 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1223ca6 name:ZooKeeperConnection Watcher:127.0.0.1:47930/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 3521 T778 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 3522 T783 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139dca76f750004 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3523 T783 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139dca76f750004 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3524 T778 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:47109_solr
[junit4:junit4]   2> 3524 T783 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139dca76f750004 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:47109_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:47109_solr
[junit4:junit4]   2> 3525 T778 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:47109_solr
[junit4:junit4]   2> 3526 T812 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 3526 T798 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 3526 T778 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 3527 T778 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 3527 T778 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 3527 T778 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 3528 T778 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 3528 T778 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 3528 T778 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 3529 T778 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 3529 T778 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 3530 T778 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 3535 T778 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 3539 T778 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./solrtest-jetty2-1348026727616/collection1
[junit4:junit4]   2> 3539 T778 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 3540 T778 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 3540 T778 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 3541 T778 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./solrtest-jetty2-1348026727616/collection1/'
[junit4:junit4]   2> 3541 T778 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/solrtest-jetty2-1348026727616/collection1/lib/README' to classloader
[junit4:junit4]   2> 3542 T778 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/solrtest-jetty2-1348026727616/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 3578 T778 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 3640 T778 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 3641 T778 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 3651 T778 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 3857 T799 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3860 T812 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3860 T798 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3860 T824 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4127 T778 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 4133 T778 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 4140 T778 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 4148 T778 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 4151 T778 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 4155 T778 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 4156 T778 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 4157 T778 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./solrtest-jetty2-1348026727616/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1348026724206/jetty2/
[junit4:junit4]   2> 4157 T778 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1b6235b
[junit4:junit4]   2> 4158 T778 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1348026724206/jetty2/index/
[junit4:junit4]   2> 4158 T778 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1348026724206/jetty2/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 4159 T778 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-1348026724206/jetty2/index forceNew:false
[junit4:junit4]   2> 4162 T778 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1348026724206/jetty2/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 4162 T778 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 4163 T778 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 4164 T778 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 4165 T778 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 4165 T778 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 4166 T778 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 4166 T778 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 4167 T778 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 4167 T778 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 4168 T778 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 4168 T778 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 4169 T778 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 4169 T778 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 4170 T778 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 4170 T778 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 4171 T778 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 4171 T778 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 4172 T778 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 4172 T778 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4173 T778 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4173 T778 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4174 T778 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4174 T778 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4175 T778 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4175 T778 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4176 T778 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 4176 T778 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 4178 T778 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 4180 T778 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 4181 T778 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SCHEMA.XML, OLD_SYNONYMS.TXT, STOPWORDS.TXT, PROTWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, SYNONYMS.TXT, CURRENCY.XML, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 4183 T778 oass.SolrIndexSearcher.<init> Opening Searcher@84aa43 main
[junit4:junit4]   2> 4184 T778 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 4184 T778 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 4184 T778 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 4188 T778 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 4208 T825 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@84aa43 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 4362 T799 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 4365 T812 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4365 T798 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4365 T824 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4712 T778 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 4712 T778 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:47109/solr shardId:shard1
[junit4:junit4]   2> 4714 T778 oasc.ZkController.register We are http://127.0.0.1:47109/solr/collection1/ and leader is http://127.0.0.1:41562/solr/collection1/
[junit4:junit4]   2> 4715 T778 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:47109/solr
[junit4:junit4]   2> 4715 T778 oasc.ZkController.checkRecovery Core needs to recover:collection1
[junit4:junit4]   2> 4715 T778 oasu.DefaultSolrCoreState.doRecovery Running recovery - first canceling any ongoing recovery
[junit4:junit4]   2> ASYNC  NEW_CORE C86 name=collection1 org.apache.solr.core.SolrCore@29e55 url=http://127.0.0.1:47109/solr/collection1 node=127.0.0.1:47109_solr
[junit4:junit4]   2> 4717 T826 C86 P47109 oasc.RecoveryStrategy.run Starting recovery process.  core=collection1 recoveringAfterStartup=true
[junit4:junit4]   2> 4717 T826 C86 P47109 oasc.RecoveryStrategy.doRecovery ###### startupVersions=[]
[junit4:junit4]   2> 4717 T778 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 4717 T826 C86 P47109 oasc.RecoveryStrategy.doRecovery Attempting to PeerSync from http://127.0.0.1:41562/solr/collection1/ core=collection1 - recoveringAfterStartup=true
[junit4:junit4]   2> 4718 T826 C86 P47109 oasu.PeerSync.sync PeerSync: core=collection1 url=http://127.0.0.1:47109/solr START replicas=[http://127.0.0.1:41562/solr/collection1/] nUpdates=100
[junit4:junit4]   2> 4718 T826 C86 P47109 oasu.PeerSync.sync WARNING no frame of reference to tell of we've missed updates
[junit4:junit4]   2> 4718 T778 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4:junit4]   2> 4718 T826 C86 P47109 oasc.RecoveryStrategy.doRecovery PeerSync Recovery was not successful - trying replication. core=collection1
[junit4:junit4]   2> 4719 T778 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 4719 T826 C86 P47109 oasc.RecoveryStrategy.doRecovery Starting Replication Recovery. core=collection1
[junit4:junit4]   2> 4719 T826 C86 P47109 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 4719 T778 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 4722 T778 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47930/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@18b92b7
[junit4:junit4]   2> 4726 T828 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47930
[junit4:junit4]   2> 4726 T778 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> ASYNC  NEW_CORE C87 name=collection1 org.apache.solr.core.SolrCore@4830f6 url=http://127.0.0.1:41562/solr/collection1 node=127.0.0.1:41562_solr
[junit4:junit4]   2> 4727 T804 C87 P41562 REQ /get {distrib=false&qt=/get&wt=javabin&version=2&getVersions=100} status=0 QTime=0 
[junit4:junit4]   2> 4727 T780 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:34515
[junit4:junit4]   2> 4727 T828 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47930, initiating session
[junit4:junit4]   2> 4727 T780 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:34515
[junit4:junit4]   2> 4728 T782 oazs.NIOServerCnxn.finishSessionInit Established session 0x139dca76f750005 with negotiated timeout 10000 for client /127.0.0.1:34515
[junit4:junit4]   2> 4729 T828 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47930, sessionid = 0x139dca76f750005, negotiated timeout = 10000
[junit4:junit4]   2> 4729 T829 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@18b92b7 name:ZooKeeperConnection Watcher:127.0.0.1:47930/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 4729 T778 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 4730 T778 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 4731 T778 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:true cause connection loss:true
[junit4:junit4]   2> 4731 T778 oascsi.HttpClientUtil.createClient Creating new http client, config:
[junit4:junit4]   2> 4733 T778 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> ASYNC  NEW_CORE C88 name=collection1 org.apache.solr.core.SolrCore@168fb5a url=http://127.0.0.1:58159/solr/collection1 node=127.0.0.1:58159_solr
[junit4:junit4]   2> 4743 T791 C88 P58159 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1348026724206/control/data/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 4743 T791 C88 P58159 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 4746 T791 C88 P58159 /update {wt=javabin&version=2} {add=[1 (1413508475329183744)]} 0 5
[junit4:junit4]   2> 4746 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10001 (1413508475329183745)]} 0 5
[junit4:junit4]   2> 4746 T831 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47930/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@1e592d9
[junit4:junit4]   2> 4747 T832 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47930
[junit4:junit4]   2> 4747 T831 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 4747 T832 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47930, initiating session
[junit4:junit4]   2> 4747 T780 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:34519
[junit4:junit4]   2> 4748 T780 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:34519
[junit4:junit4]   2> 4748 T782 oazs.NIOServerCnxn.finishSessionInit Established session 0x139dca76f750006 with negotiated timeout 10000 for client /127.0.0.1:34519
[junit4:junit4]   2> 4748 T832 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47930, sessionid = 0x139dca76f750006, negotiated timeout = 10000
[junit4:junit4]   2> 4749 T833 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1e592d9 name:ZooKeeperConnection Watcher:127.0.0.1:47930/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 4749 T831 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 4749 T831 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 4753 T806 C87 P41562 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1348026724206/jetty1/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 4754 T806 C87 P41562 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 4757 T807 C87 P41562 /update {wt=javabin&version=2} {add=[1 (1413508475339669505)]} 0 6
[junit4:junit4]   2> 4757 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10001 (1413508475339669504)]} 0 6
[junit4:junit4]   2> 4760 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[10001 (-1413508475348058112)]} 0 1
[junit4:junit4]   2> 4760 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[1 (-1413508475348058113)]} 0 1
[junit4:junit4]   2> 4761 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10001 (-1413508475350155264)]} 0 0
[junit4:junit4]   2> 4762 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[1 (-1413508475350155265)]} 0 1
[junit4:junit4]   2> 4764 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10002 (1413508475353300992)]} 0 1
[junit4:junit4]   2> 4764 T791 C88 P58159 /update {wt=javabin&version=2} {add=[2 (1413508475353300993)]} 0 0
[junit4:junit4]   2> 4766 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10002 (1413508475355398144)]} 0 0
[junit4:junit4]   2> 4767 T806 C87 P41562 /update {wt=javabin&version=2} {add=[2 (1413508475355398145)]} 0 1
[junit4:junit4]   2> 4768 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[10002 (-1413508475357495296)]} 0 0
[junit4:junit4]   2> 4769 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[2 (-1413508475358543872)]} 0 0
[junit4:junit4]   2> 4771 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10002 (-1413508475360641024)]} 0 1
[junit4:junit4]   2> 4771 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[2 (-1413508475360641025)]} 0 0
[junit4:junit4]   2> 4773 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10003 (1413508475362738176)]} 0 0
[junit4:junit4]   2> 4773 T791 C88 P58159 /update {wt=javabin&version=2} {add=[3 (1413508475362738177)]} 0 0
[junit4:junit4]   2> 4776 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10003 (1413508475364835328)]} 0 1
[junit4:junit4]   2> 4776 T806 C87 P41562 /update {wt=javabin&version=2} {add=[3 (1413508475364835329)]} 0 1
[junit4:junit4]   2> 4778 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10004 (1413508475367981056)]} 0 0
[junit4:junit4]   2> 4778 T790 C88 P58159 /update {wt=javabin&version=2} {add=[4 (1413508475367981057)]} 0 0
[junit4:junit4]   2> 4781 T807 C87 P41562 /update {wt=javabin&version=2} {add=[4 (1413508475370078209)]} 0 1
[junit4:junit4]   2> 4781 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10004 (1413508475370078208)]} 0 1
[junit4:junit4]   2> 4783 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[3 (-1413508475373223937)]} 0 0
[junit4:junit4]   2> 4783 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10003 (-1413508475373223936)]} 0 0
[junit4:junit4]   2> 4785 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[10003 (-1413508475375321088)]} 0 1
[junit4:junit4]   2> 4785 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[3 (-1413508475375321089)]} 0 1
[junit4:junit4]   2> 4787 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10005 (1413508475376369664)]} 0 1
[junit4:junit4]   2> 4787 T791 C88 P58159 /update {wt=javabin&version=2} {add=[5 (1413508475377418240)]} 0 0
[junit4:junit4]   2> 4790 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10005 (1413508475379515392)]} 0 1
[junit4:junit4]   2> 4790 T807 C87 P41562 /update {wt=javabin&version=2} {add=[5 (1413508475379515393)]} 0 1
[junit4:junit4]   2> 4792 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[10004 (-1413508475382661120)]} 0 1
[junit4:junit4]   2> 4792 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[4 (-1413508475382661121)]} 0 0
[junit4:junit4]   2> 4794 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[10004 (-1413508475384758272)]} 0 1
[junit4:junit4]   2> 4794 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[4 (-1413508475384758273)]} 0 0
[junit4:junit4]   2> 4796 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10006 (1413508475386855424)]} 0 0
[junit4:junit4]   2> 4797 T791 C88 P58159 /update {wt=javabin&version=2} {add=[6 (1413508475386855425)]} 0 1
[junit4:junit4]   2> 4798 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10006 (1413508475388952576)]} 0 0
[junit4:junit4]   2> 4799 T807 C87 P41562 /update {wt=javabin&version=2} {add=[6 (1413508475388952577)]} 0 1
[junit4:junit4]   2> 4801 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10007 (1413508475391049728)]} 0 1
[junit4:junit4]   2> 4801 T790 C88 P58159 /update {wt=javabin&version=2} {add=[7 (1413508475392098304)]} 0 1
[junit4:junit4]   2> 4803 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10007 (1413508475394195456)]} 0 0
[junit4:junit4]   2> 4804 T806 C87 P41562 /update {wt=javabin&version=2} {add=[7 (1413508475394195457)]} 0 1
[junit4:junit4]   2> 4806 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10008 (1413508475396292608)]} 0 1
[junit4:junit4]   2> 4806 T791 C88 P58159 /update {wt=javabin&version=2} {add=[8 (1413508475396292609)]} 0 1
[junit4:junit4]   2> 4808 T807 C87 P41562 /update {wt=javabin&version=2} {add=[8 (1413508475399438337)]} 0 0
[junit4:junit4]   2> 4808 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10008 (1413508475399438336)]} 0 0
[junit4:junit4]   2> 4811 T791 C88 P58159 /update {wt=javabin&version=2} {add=[9 (1413508475401535488)]} 0 1
[junit4:junit4]   2> 4811 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10009 (1413508475401535489)]} 0 1
[junit4:junit4]   2> 4813 T806 C87 P41562 /update {wt=javabin&version=2} {add=[9 (1413508475403632640)]} 0 1
[junit4:junit4]   2> 4813 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10009 (1413508475404681216)]} 0 0
[junit4:junit4]   2> 4815 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[6 (-1413508475406778368)]} 0 0
[junit4:junit4]   2> 4816 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[10006 (-1413508475406778369)]} 0 1
[junit4:junit4]   2> 4817 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[6 (-1413508475408875520)]} 0 0
[junit4:junit4]   2> 4817 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10006 (-1413508475408875521)]} 0 0
[junit4:junit4]   2> 4823 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10010 (1413508475410972673)]} 0 4
[junit4:junit4]   2> 4824 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10 (1413508475410972672)]} 0 5
[junit4:junit4]   2> 4828 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10010 (1413508475417264128)]} 0 4
[junit4:junit4]   2> 4829 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10 (1413508475418312704)]} 0 3
[junit4:junit4]   2> 4834 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10011 (1413508475421458432)]} 0 5
[junit4:junit4]   2> 4835 T790 C88 P58159 /update {wt=javabin&version=2} {add=[11 (1413508475426701312)]} 0 1
[junit4:junit4]   2> 4836 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10011 (1413508475428798464)]} 0 1
[junit4:junit4]   2> 4838 T806 C87 P41562 /update {wt=javabin&version=2} {add=[11 (1413508475429847040)]} 0 1
[junit4:junit4]   2> 4838 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10008 (-1413508475430895616)]} 0 0
[junit4:junit4]   2> 4840 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[8 (-1413508475432992768)]} 0 0
[junit4:junit4]   2> 4840 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10008 (-1413508475432992768)]} 0 0
[junit4:junit4]   2> 4842 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[8 (-1413508475435089920)]} 0 1
[junit4:junit4]   2> 4842 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10012 (1413508475435089920)]} 0 0
[junit4:junit4]   2> 4844 T790 C88 P58159 /update {wt=javabin&version=2} {add=[12 (1413508475436138496)]} 0 1
[junit4:junit4]   2> 4844 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10012 (1413508475437187072)]} 0 0
[junit4:junit4]   2> 4846 T806 C87 P41562 /update {wt=javabin&version=2} {add=[12 (1413508475439284224)]} 0 0
[junit4:junit4]   2> 4846 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10010 (-1413508475439284224)]} 0 0
[junit4:junit4]   2> 4848 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[10 (-1413508475441381376)]} 0 0
[junit4:junit4]   2> 4848 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10010 (-1413508475441381376)]} 0 0
[junit4:junit4]   2> 4850 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[10 (-1413508475443478528)]} 0 0
[junit4:junit4]   2> 4850 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10013 (1413508475443478528)]} 0 0
[junit4:junit4]   2> 4852 T790 C88 P58159 /update {wt=javabin&version=2} {add=[13 (1413508475445575680)]} 0 0
[junit4:junit4]   2> 4852 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10013 (1413508475445575680)]} 0 0
[junit4:junit4]   2> 4854 T806 C87 P41562 /update {wt=javabin&version=2} {add=[13 (1413508475447672832)]} 0 0
[junit4:junit4]   2> 4855 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10014 (1413508475447672832)]} 0 1
[junit4:junit4]   2> 4857 T791 C88 P58159 /update {wt=javabin&version=2} {add=[14 (1413508475449769984)]} 0 1
[junit4:junit4]   2> 4857 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10014 (1413508475449769984)]} 0 1
[junit4:junit4]   2> 4859 T807 C87 P41562 /update {wt=javabin&version=2} {add=[14 (1413508475452915712)]} 0 1
[junit4:junit4]   2> 4859 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10015 (1413508475452915712)]} 0 0
[junit4:junit4]   2> 4861 T790 C88 P58159 /update {wt=javabin&version=2} {add=[15 (1413508475455012864)]} 0 0
[junit4:junit4]   2> 4862 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10015 (1413508475455012864)]} 0 1
[junit4:junit4]   2> 4864 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10012 (-1413508475457110016)]} 0 1
[junit4:junit4]   2> 4864 T806 C87 P41562 /update {wt=javabin&version=2} {add=[15 (1413508475457110016)]} 0 1
[junit4:junit4]   2> 4865 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[10012 (-1413508475459207168)]} 0 0
[junit4:junit4]   2> 4865 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[12 (-1413508475459207168)]} 0 0
[junit4:junit4]   2> 4867 T799 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 4867 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[12 (-1413508475461304320)]} 0 0
[junit4:junit4]   2> 4868 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10016 (1413508475461304320)]} 0 1
[junit4:junit4]   2> 4869 T833 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4869 T824 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4869 T812 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4869 T798 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4869 T829 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4870 T790 C88 P58159 /update {wt=javabin&version=2} {add=[16 (1413508475464450048)]} 0 1
[junit4:junit4]   2> 4871 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10016 (1413508475464450048)]} 0 1
[junit4:junit4]   2> 4872 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10013 (-1413508475466547200)]} 0 0
[junit4:junit4]   2>  C86_STATE=coll:collection1 core:collection1 props:{shard=shard1, roles=null, state=recovering, core=collection1, collection=collection1, node_name=127.0.0.1:47109_solr, base_url=http://127.0.0.1:47109/solr}
[junit4:junit4]   2> 4878 T816 C86 P47109 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1348026724206/jetty2/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 4879 T816 C86 P47109 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 4880 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 4880 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[10013 (-1413508475468644352)]} 0 6
[junit4:junit4]   2> 4881 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 4881 T806 C87 P41562 /update {wt=javabin&version=2} {add=[16 (1413508475466547200)]} 0 9
[junit4:junit4]   2> 4883 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10017 (1413508475477032960)]} 0 1
[junit4:junit4]   2> 4883 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[13 (-1413508475478081536)]} 0 0
[junit4:junit4]   2> 4887 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 4887 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[13 (-1413508475480178689)]} 0 2
[junit4:junit4]   2> 4887 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 4888 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10017 (1413508475480178688)]} 0 3
[junit4:junit4]   2> 4889 T791 C88 P58159 /update {wt=javabin&version=2} {add=[17 (1413508475484372992)]} 0 0
[junit4:junit4]   2> 4890 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10018 (1413508475485421568)]} 0 0
[junit4:junit4]   2> 4893 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 4894 T806 C87 P41562 /update {wt=javabin&version=2} {add=[17 (1413508475486470144)]} 0 3
[junit4:junit4]   2> 4894 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 4894 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10018 (1413508475487518720)]} 0 2
[junit4:junit4]   2> 4896 T790 C88 P58159 /update {wt=javabin&version=2} {add=[18 (1413508475490664448)]} 0 1
[junit4:junit4]   2> 4896 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[10014 (-1413508475491713024)]} 0 0
[junit4:junit4]   2> 4900 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 4900 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 4900 T807 C87 P41562 /update {wt=javabin&version=2} {add=[18 (1413508475492761600)]} 0 3
[junit4:junit4]   2> 4900 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10014 (-1413508475493810176)]} 0 2
[junit4:junit4]   2> 4902 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[14 (-1413508475498004480)]} 0 0
[junit4:junit4]   2> 4906 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 4906 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10019 (1413508475498004481)]} 0 4
[junit4:junit4]   2> 4906 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[14 (-1413508475500101632)]} 0 2
[junit4:junit4]   2> 4909 T790 C88 P58159 /update {wt=javabin&version=2} {add=[19 (1413508475504295936)]} 0 1
[junit4:junit4]   2> 4910 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 4911 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10019 (1413508475504295936)]} 0 3
[junit4:junit4]   2> 4913 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10020 (1413508475508490240)]} 0 1
[junit4:junit4]   2> 4914 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 4915 T806 C87 P41562 /update {wt=javabin&version=2} {add=[19 (1413508475507441664)]} 0 4
[junit4:junit4]   2> 4917 T790 C88 P58159 /update {wt=javabin&version=2} {add=[20 (1413508475513733120)]} 0 1
[junit4:junit4]   2> 4920 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 4921 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10020 (1413508475511635968)]} 0 6
[junit4:junit4]   2> 4923 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10015 (-1413508475520024576)]} 0 1
[junit4:junit4]   2> 4924 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 4937 T806 C87 P41562 /update {wt=javabin&version=2} {add=[20 (1413508475515830272)]} 0 18
[junit4:junit4]   2> 4938 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 4938 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[15 (-1413508475535753216)]} 0 0
[junit4:junit4]   2> 4939 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[10015 (-1413508475534704640)]} 0 2
[junit4:junit4]   2> 4941 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10021 (1413508475538898944)]} 0 1
[junit4:junit4]   2> 4942 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 4942 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[15 (-1413508475537850368)]} 0 2
[junit4:junit4]   2> 4945 T790 C88 P58159 /update {wt=javabin&version=2} {add=[21 (1413508475542044672)]} 0 1
[junit4:junit4]   2> 4948 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 4948 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10021 (1413508475540996096)]} 0 5
[junit4:junit4]   2> 4950 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 4950 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10022 (1413508475548336128)]} 0 0
[junit4:junit4]   2> 4950 T806 C87 P41562 /update {wt=javabin&version=2} {add=[21 (1413508475544141824)]} 0 4
[junit4:junit4]   2> 4953 T790 C88 P58159 /update {wt=javabin&version=2} {add=[22 (1413508475550433280)]} 0 1
[junit4:junit4]   2> 4955 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 4955 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10022 (1413508475550433280)]} 0 3
[junit4:junit4]   2> 4957 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 4957 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10016 (-1413508475555676160)]} 0 0
[junit4:junit4]   2> 4957 T806 C87 P41562 /update {wt=javabin&version=2} {add=[22 (1413508475552530432)]} 0 3
[junit4:junit4]   2> 4959 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[16 (-1413508475557773312)]} 0 0
[junit4:junit4]   2> 4960 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 4961 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[10016 (-1413508475557773312)]} 0 2
[junit4:junit4]   2> 4962 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 4962 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[16 (-1413508475558821888)]} 0 2
[junit4:junit4]   2> 4963 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10023 (1413508475560919040)]} 0 1
[junit4:junit4]   2> 4965 T791 C88 P58159 /update {wt=javabin&version=2} {add=[23 (1413508475563016192)]} 0 1
[junit4:junit4]   2> 4967 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 4967 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10023 (1413508475563016192)]} 0 3
[junit4:junit4]   2> 4969 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 4969 T807 C87 P41562 /update {wt=javabin&version=2} {add=[23 (1413508475565113344)]} 0 3
[junit4:junit4]   2> 4969 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10024 (1413508475568259072)]} 0 0
[junit4:junit4]   2> 4971 T790 C88 P58159 /update {wt=javabin&version=2} {add=[24 (1413508475570356224)]} 0 0
[junit4:junit4]   2> 4974 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 4974 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10024 (1413508475570356224)]} 0 3
[junit4:junit4]   2> 4975 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 4976 T806 C87 P41562 /update {wt=javabin&version=2} {add=[24 (1413508475572453376)]} 0 3
[junit4:junit4]   2> 4976 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10017 (-1413508475575599104)]} 0 0
[junit4:junit4]   2> 4977 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[17 (-1413508475576647680)]} 0 0
[junit4:junit4]   2> 4979 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 4980 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10017 (-1413508475577696256)]} 0 2
[junit4:junit4]   2> 4981 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 4981 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[17 (-1413508475578744832)]} 0 2
[junit4:junit4]   2> 4986 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10025 (1413508475580841984)]} 0 5
[junit4:junit4]   2> 4987 T790 C88 P58159 /update {wt=javabin&version=2} {add=[25 (1413508475582939136)]} 0 4
[junit4:junit4]   2> 4990 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 4991 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10025 (1413508475588182016)]} 0 3
[junit4:junit4]   2> 4991 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 4991 T806 C87 P41562 /update {wt=javabin&version=2} {add=[25 (1413508475589230592)]} 0 2
[junit4:junit4]   2> 4993 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10018 (-1413508475592376320)]} 0 1
[junit4:junit4]   2> 4993 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[18 (-1413508475593424896)]} 0 0
[junit4:junit4]   2> 4996 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 4996 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10018 (-1413508475594473472)]} 0 2
[junit4:junit4]   2> 4997 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 4997 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[18 (-1413508475595522048)]} 0 2
[junit4:junit4]   2> 4999 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10026 (1413508475598667776)]} 0 1
[junit4:junit4]   2> 5000 T790 C88 P58159 /update {wt=javabin&version=2} {add=[26 (1413508475599716352)]} 0 1
[junit4:junit4]   2> 5005 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5006 T806 C87 P41562 /update {wt=javabin&version=2} {add=[26 (1413508475602862080)]} 0 4
[junit4:junit4]   2> 5007 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 5007 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10026 (1413508475601813504)]} 0 6
[junit4:junit4]   2> 5009 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[21 (-1413508475610202112)]} 0 1
[junit4:junit4]   2> 5009 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[10021 (-1413508475610202113)]} 0 0
[junit4:junit4]   2> 5012 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5013 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[21 (-1413508475611250688)]} 0 3
[junit4:junit4]   2> 5013 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5013 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10021 (-1413508475612299264)]} 0 2
[junit4:junit4]   2> 5015 T791 C88 P58159 /update {wt=javabin&version=2} {add=[27 (1413508475615444992)]} 0 1
[junit4:junit4]   2> 5016 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10027 (1413508475616493568)]} 0 1
[junit4:junit4]   2> 5020 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5020 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5020 T806 C87 P41562 /update {wt=javabin&version=2} {add=[27 (1413508475618590720)]} 0 4
[junit4:junit4]   2> 5020 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10027 (1413508475619639296)]} 0 3
[junit4:junit4]   2> 5022 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[22 (-1413508475623833600)]} 0 0
[junit4:junit4]   2> 5022 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[10022 (-1413508475623833601)]} 0 0
[junit4:junit4]   2> 5026 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5026 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5027 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[22 (-1413508475625930752)]} 0 2
[junit4:junit4]   2> 5027 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10022 (-1413508475625930753)]} 0 3
[junit4:junit4]   2> 5029 T791 C88 P58159 /update {wt=javabin&version=2} {add=[28 (1413508475630125056)]} 0 1
[junit4:junit4]   2> 5029 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10028 (1413508475631173632)]} 0 1
[junit4:junit4]   2> 5033 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5033 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5033 T806 C87 P41562 /update {wt=javabin&version=2} {add=[28 (1413508475632222208)]} 0 3
[junit4:junit4]   2> 5034 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10028 (1413508475633270784)]} 0 3
[junit4:junit4]   2> 5036 T790 C88 P58159 /update {wt=javabin&version=2} {add=[29 (1413508475637465088)]} 0 1
[junit4:junit4]   2> 5036 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10029 (1413508475637465089)]} 0 1
[junit4:junit4]   2> 5040 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5040 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5040 T807 C87 P41562 /update {wt=javabin&version=2} {add=[29 (1413508475639562240)]} 0 3
[junit4:junit4]   2> 5040 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10029 (1413508475640610816)]} 0 3
[junit4:junit4]   2> 5042 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[23 (-1413508475644805120)]} 0 0
[junit4:junit4]   2> 5042 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10023 (-1413508475644805121)]} 0 0
[junit4:junit4]   2> 5046 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5046 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5046 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[23 (-1413508475646902272)]} 0 2
[junit4:junit4]   2> 5047 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[10023 (-1413508475646902273)]} 0 3
[junit4:junit4]   2> 5049 T790 C88 P58159 /update {wt=javabin&version=2} {add=[30 (1413508475651096576)]} 0 1
[junit4:junit4]   2> 5049 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10030 (1413508475652145152)]} 0 1
[junit4:junit4]   2> 5056 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5056 T807 C87 P41562 /update {wt=javabin&version=2} {add=[30 (1413508475654242304)]} 0 6
[junit4:junit4]   2> 5057 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5058 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10030 (1413508475654242305)]} 0 7
[junit4:junit4]   2> 5058 T791 C88 P58159 /update {wt=javabin&version=2} {add=[31 (1413508475661582336)]} 0 0
[junit4:junit4]   2> 5060 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10031 (1413508475662630912)]} 0 1
[junit4:junit4]   2> 5068 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5069 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10031 (1413508475668922368)]} 0 5
[junit4:junit4]   2> 5070 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 5070 T806 C87 P41562 /update {wt=javabin&version=2} {add=[31 (1413508475663679488)]} 0 10
[junit4:junit4]   2> 5071 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10024 (-1413508475675213824)]} 0 0
[junit4:junit4]   2> 5072 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[24 (-1413508475676262400)]} 0 0
[junit4:junit4]   2> 5075 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5075 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10024 (-1413508475677310976)]} 0 2
[junit4:junit4]   2> 5077 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5077 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[24 (-1413508475679408128)]} 0 3
[junit4:junit4]   2> 5077 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10032 (1413508475681505280)]} 0 0
[junit4:junit4]   2> 5079 T790 C88 P58159 /update {wt=javabin&version=2} {add=[32 (1413508475683602432)]} 0 0
[junit4:junit4]   2> 5081 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5082 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10032 (1413508475683602432)]} 0 3
[junit4:junit4]   2> 5084 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5084 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10025 (-1413508475688845312)]} 0 1
[junit4:junit4]   2> 5084 T806 C87 P41562 /update {wt=javabin&version=2} {add=[32 (1413508475685699584)]} 0 3
[junit4:junit4]   2> 5086 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[25 (-1413508475690942464)]} 0 0
[junit4:junit4]   2> 5088 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5088 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[10025 (-1413508475690942464)]} 0 2
[junit4:junit4]   2> 5090 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5090 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[25 (-1413508475693039616)]} 0 2
[junit4:junit4]   2> 5090 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10033 (1413508475695136768)]} 0 0
[junit4:junit4]   2> 5092 T791 C88 P58159 /update {wt=javabin&version=2} {add=[33 (1413508475697233920)]} 0 0
[junit4:junit4]   2> 5095 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5095 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10033 (1413508475697233920)]} 0 3
[junit4:junit4]   2> 5097 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5097 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[10026 (-1413508475702476800)]} 0 0
[junit4:junit4]   2> 5097 T807 C87 P41562 /update {wt=javabin&version=2} {add=[33 (1413508475699331072)]} 0 3
[junit4:junit4]   2> 5099 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[26 (-1413508475704573952)]} 0 0
[junit4:junit4]   2> 5100 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5101 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10026 (-1413508475704573952)]} 0 2
[junit4:junit4]   2> 5102 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5103 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[26 (-1413508475706671104)]} 0 2
[junit4:junit4]   2> 5103 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10034 (1413508475708768256)]} 0 0
[junit4:junit4]   2> 5105 T790 C88 P58159 /update {wt=javabin&version=2} {add=[34 (1413508475710865408)]} 0 1
[junit4:junit4]   2> 5107 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5108 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10034 (1413508475710865408)]} 0 3
[junit4:junit4]   2> 5109 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5109 T806 C87 P41562 /update {wt=javabin&version=2} {add=[34 (1413508475712962560)]} 0 2
[junit4:junit4]   2> 5113 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10035 (1413508475716108288)]} 0 4
[junit4:junit4]   2> 5115 T791 C88 P58159 /update {wt=javabin&version=2} {add=[35 (1413508475718205440)]} 0 4
[junit4:junit4]   2> 5117 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5118 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10035 (1413508475721351168)]} 0 3
[junit4:junit4]   2> 5119 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5119 T807 C87 P41562 /update {wt=javabin&version=2} {add=[35 (1413508475723448320)]} 0 3
[junit4:junit4]   2> 5121 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10036 (1413508475726594048)]} 0 1
[junit4:junit4]   2> 5122 T790 C88 P58159 /update {wt=javabin&version=2} {add=[36 (1413508475727642624)]} 0 1
[junit4:junit4]   2> 5128 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 5129 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 5129 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10036 (1413508475729739776)]} 0 6
[junit4:junit4]   2> 5130 T806 C87 P41562 /update {wt=javabin&version=2} {add=[36 (1413508475730788352)]} 0 6
[junit4:junit4]   2> 5133 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10037 (1413508475739176960)]} 0 1
[junit4:junit4]   2> 5134 T791 C88 P58159 /update {wt=javabin&version=2} {add=[37 (1413508475740225536)]} 0 1
[junit4:junit4]   2> 5140 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5140 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5141 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10037 (1413508475743371264)]} 0 5
[junit4:junit4]   2> 5141 T807 C87 P41562 /update {wt=javabin&version=2} {add=[37 (1413508475744419840)]} 0 5
[junit4:junit4]   2> 5143 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10038 (1413508475750711296)]} 0 0
[junit4:junit4]   2> 5144 T790 C88 P58159 /update {wt=javabin&version=2} {add=[38 (1413508475750711297)]} 0 1
[junit4:junit4]   2> 5148 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5148 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5148 T806 C87 P41562 /update {wt=javabin&version=2} {add=[38 (1413508475752808449)]} 0 3
[junit4:junit4]   2> 5149 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10038 (1413508475752808448)]} 0 4
[junit4:junit4]   2> 5151 T790 C88 P58159 /update {wt=javabin&version=2} {add=[39 (1413508475758051328)]} 0 1
[junit4:junit4]   2> 5151 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10039 (1413508475759099904)]} 0 1
[junit4:junit4]   2> 5155 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5156 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5156 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10039 (1413508475761197057)]} 0 3
[junit4:junit4]   2> 5156 T807 C87 P41562 /update {wt=javabin&version=2} {add=[39 (1413508475761197056)]} 0 3
[junit4:junit4]   2> 5158 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10040 (1413508475766439936)]} 0 0
[junit4:junit4]   2> 5159 T790 C88 P58159 /update {wt=javabin&version=2} {add=[40 (1413508475766439937)]} 0 1
[junit4:junit4]   2> 5165 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5166 T806 C87 P41562 /update {wt=javabin&version=2} {add=[40 (1413508475769585664)]} 0 5
[junit4:junit4]   2> 5168 T790 C88 P58159 /update {wt=javabin&version=2} {add=[41 (1413508475775877120)]} 0 1
[junit4:junit4]   2> 5173 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5173 T806 C87 P41562 /update {wt=javabin&version=2} {add=[41 (1413508475779022848)]} 0 3
[junit4:junit4]   2> 5176 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[27 (-1413508475784265728)]} 0 1
[junit4:junit4]   2> 5182 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5183 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[27 (-1413508475790557184)]} 0 2
[junit4:junit4]   2> 5185 T790 C88 P58159 /update {wt=javabin&version=2} {add=[42 (1413508475794751488)]} 0 0
[junit4:junit4]   2> 5188 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 5188 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10040 (1413508475768537088)]} 0 28
[junit4:junit4]   2> 5192 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5192 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10041 (1413508475802091520)]} 0 0
[junit4:junit4]   2> 5192 T806 C87 P41562 /update {wt=javabin&version=2} {add=[42 (1413508475796848640)]} 0 5
[junit4:junit4]   2> 5195 T790 C88 P58159 /update {wt=javabin&version=2} {add=[43 (1413508475804188672)]} 0 1
[junit4:junit4]   2> 5197 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5197 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10041 (1413508475804188672)]} 0 3
[junit4:junit4]   2> 5199 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5199 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10027 (-1413508475809431552)]} 0 0
[junit4:junit4]   2> 5200 T806 C87 P41562 /update {wt=javabin&version=2} {add=[43 (1413508475807334400)]} 0 4
[junit4:junit4]   2> 5201 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[30 (-1413508475811528704)]} 0 0
[junit4:junit4]   2> 5203 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5203 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[10027 (-1413508475811528704)]} 0 2
[junit4:junit4]   2> 5205 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5205 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[30 (-1413508475813625856)]} 0 2
[junit4:junit4]   2> 5207 T791 C88 P58159 /update {wt=javabin&version=2} {add=[44 (1413508475817820160)]} 0 0
[junit4:junit4]   2> 5212 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5212 T806 C87 P41562 /update {wt=javabin&version=2} {add=[44 (1413508475819917312)]} 0 3
[junit4:junit4]   2> 5214 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[32 (-1413508475825160192)]} 0 0
[junit4:junit4]   2> 5217 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5218 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[32 (-1413508475827257344)]} 0 2
[junit4:junit4]   2> 5220 T791 C88 P58159 /update {wt=javabin&version=2} {add=[45 (1413508475831451648)]} 0 0
[junit4:junit4]   2> 5224 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10042 (1413508475815723008)]} 0 19
[junit4:junit4]   2> 5225 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5225 T806 C87 P41562 /update {wt=javabin&version=2} {add=[45 (1413508475833548800)]} 0 3
[junit4:junit4]   2> 5227 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[33 (-1413508475838791680)]} 0 0
[junit4:junit4]   2> 5228 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5229 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10042 (1413508475836694528)]} 0 4
[junit4:junit4]   2> 5230 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5231 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[33 (-1413508475840888832)]} 0 2
[junit4:junit4]   2> 5240 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10043 (1413508475842985984)]} 0 9
[junit4:junit4]   2> 5242 T791 C88 P58159 /update {wt=javabin&version=2} {add=[46 (1413508475853471744)]} 0 1
[junit4:junit4]   2> 5244 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5245 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10043 (1413508475854520320)]} 0 3
[junit4:junit4]   2> 5246 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5246 T807 C87 P41562 /update {wt=javabin&version=2} {add=[46 (1413508475856617472)]} 0 2
[junit4:junit4]   2> 5247 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[10030 (-1413508475859763200)]} 0 0
[junit4:junit4]   2> 5248 T790 C88 P58159 /update {wt=javabin&version=2} {add=[47 (1413508475860811776)]} 0 0
[junit4:junit4]   2> 5250 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5250 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[10030 (-1413508475860811776)]} 0 2
[junit4:junit4]   2> 5253 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5253 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10044 (1413508475865006080)]} 0 1
[junit4:junit4]   2> 5253 T806 C87 P41562 /update {wt=javabin&version=2} {add=[47 (1413508475862908928)]} 0 3
[junit4:junit4]   2> 5255 T790 C88 P58159 /update {wt=javabin&version=2} {add=[48 (1413508475868151808)]} 0 0
[junit4:junit4]   2> 5259 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 5260 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5260 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10044 (1413508475867103232)]} 0 6
[junit4:junit4]   2> 5260 T806 C87 P41562 /update {wt=javabin&version=2} {add=[48 (1413508475870248960)]} 0 3
[junit4:junit4]   2> 5262 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10032 (-1413508475875491840)]} 0 0
[junit4:junit4]   2> 5262 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[35 (-1413508475875491841)]} 0 0
[junit4:junit4]   2> 5265 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5266 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10032 (-1413508475877588992)]} 0 3
[junit4:junit4]   2> 5266 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5266 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[35 (-1413508475877588993)]} 0 2
[junit4:junit4]   2> 5268 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10045 (1413508475880734720)]} 0 1
[junit4:junit4]   2> 5268 T790 C88 P58159 /update {wt=javabin&version=2} {add=[49 (1413508475881783296)]} 0 0
[junit4:junit4]   2> 5272 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5272 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10045 (1413508475883880448)]} 0 2
[junit4:junit4]   2> 5272 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5273 T806 C87 P41562 /update {wt=javabin&version=2} {add=[49 (1413508475883880449)]} 0 3
[junit4:junit4]   2> 5274 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10033 (-1413508475888074752)]} 0 0
[junit4:junit4]   2> 5277 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5278 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10033 (-1413508475890171904)]} 0 2
[junit4:junit4]   2> 5278 T791 C88 P58159 /update {wt=javabin&version=2} {add=[50 (1413508475889123328)]} 0 4
[junit4:junit4]   2> 5280 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10046 (1413508475894366208)]} 0 0
[junit4:junit4]   2> 5284 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5284 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10046 (1413508475896463360)]} 0 2
[junit4:junit4]   2> 5285 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5285 T806 C87 P41562 /update {wt=javabin&version=2} {add=[50 (1413508475894366208)]} 0 5
[junit4:junit4]   2> 5286 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10047 (1413508475900657664)]} 0 0
[junit4:junit4]   2> 5287 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[37 (-1413508475901706240)]} 0 0
[junit4:junit4]   2> 5291 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5291 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[37 (-1413508475903803392)]} 0 2
[junit4:junit4]   2> 5291 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5292 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10047 (1413508475902754816)]} 0 4
[junit4:junit4]   2> 5294 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10048 (1413508475907997697)]} 0 1
[junit4:junit4]   2> 5294 T791 C88 P58159 /update {wt=javabin&version=2} {add=[51 (1413508475907997696)]} 0 1
[junit4:junit4]   2> 5298 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5298 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5298 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10048 (1413508475911143424)]} 0 2
[junit4:junit4]   2> 5299 T807 C87 P41562 /update {wt=javabin&version=2} {add=[51 (1413508475911143425)]} 0 3
[junit4:junit4]   2> 5300 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[10035 (-1413508475915337728)]} 0 0
[junit4:junit4]   2> 5301 T790 C88 P58159 /update {wt=javabin&version=2} {add=[52 (1413508475915337729)]} 0 1
[junit4:junit4]   2> 5304 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5304 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[10035 (-1413508475917434880)]} 0 2
[junit4:junit4]   2> 5305 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5305 T806 C87 P41562 /update {wt=javabin&version=2} {add=[52 (1413508475918483456)]} 0 2
[junit4:junit4]   2> 5307 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[38 (-1413508475922677760)]} 0 0
[junit4:junit4]   2> 5309 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10049 (1413508475921629184)]} 0 3
[junit4:junit4]   2> 5311 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5311 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[38 (-1413508475924774912)]} 0 2
[junit4:junit4]   2> 5314 T790 C88 P58159 /update {wt=javabin&version=2} {add=[53 (1413508475928969216)]} 0 1
[junit4:junit4]   2> 5316 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 5316 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10049 (1413508475926872064)]} 0 5
[junit4:junit4]   2> 5318 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10050 (1413508475934212096)]} 0 0
[junit4:junit4]   2> 5318 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5319 T806 C87 P41562 /update {wt=javabin&version=2} {add=[53 (1413508475932114944)]} 0 4
[junit4:junit4]   2> 5321 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[39 (-1413508475937357824)]} 0 0
[junit4:junit4]   2> 5324 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5324 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5325 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10050 (1413508475936309248)]} 0 5
[junit4:junit4]   2> 5325 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[39 (-1413508475939454976)]} 0 2
[junit4:junit4]   2> 5327 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10037 (-1413508475942600704)]} 0 1
[junit4:junit4]   2> 5327 T791 C88 P58159 /update {wt=javabin&version=2} {add=[54 (1413508475943649280)]} 0 1
[junit4:junit4]   2> 5330 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5330 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10037 (-1413508475944697856)]} 0 2
[junit4:junit4]   2> 5332 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10051 (1413508475948892160)]} 0 0
[junit4:junit4]   2> 5334 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5334 T807 C87 P41562 /update {wt=javabin&version=2} {add=[54 (1413508475945746432)]} 0 5
[junit4:junit4]   2> 5336 T791 C88 P58159 /update {wt=javabin&version=2} {add=[55 (1413508475953086464)]} 0 0
[junit4:junit4]   2> 5340 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 5340 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10051 (1413508475950989312)]} 0 6
[junit4:junit4]   2> 5342 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10052 (1413508475959377920)]} 0 0
[junit4:junit4]   2> 5344 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5345 T807 C87 P41562 /update {wt=javabin&version=2} {add=[55 (1413508475958329344)]} 0 4
[junit4:junit4]   2> 5346 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5346 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[42 (-1413508475963572224)]} 0 0
[junit4:junit4]   2> 5347 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10052 (1413508475961475072)]} 0 3
[junit4:junit4]   2> 5348 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[10038 (-1413508475965669376)]} 0 0
[junit4:junit4]   2> 5350 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5350 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[42 (-1413508475965669376)]} 0 2
[junit4:junit4]   2> 5352 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5352 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10038 (-1413508475967766528)]} 0 2
[junit4:junit4]   2> 5352 T791 C88 P58159 /update {wt=javabin&version=2} {add=[56 (1413508475969863680)]} 0 0
[junit4:junit4]   2> 5355 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10053 (1413508475971960832)]} 0 1
[junit4:junit4]   2> 5356 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5357 T806 C87 P41562 /update {wt=javabin&version=2} {add=[56 (1413508475971960832)]} 0 3
[junit4:junit4]   2> 5359 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[44 (-1413508475976155136)]} 0 1
[junit4:junit4]   2> 5359 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5359 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10053 (1413508475974057984)]} 0 3
[junit4:junit4]   2> 5361 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10039 (-1413508475979300864)]} 0 0
[junit4:junit4]   2> 5362 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5362 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[44 (-1413508475979300864)]} 0 2
[junit4:junit4]   2> 5366 T790 C88 P58159 /update {wt=javabin&version=2} {add=[57 (1413508475983495168)]} 0 0
[junit4:junit4]   2> 5367 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5367 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[10039 (-1413508475983495168)]} 0 2
[junit4:junit4]   2> 5369 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10054 (1413508475987689472)]} 0 0
[junit4:junit4]   2> 5369 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5370 T806 C87 P41562 /update {wt=javabin&version=2} {add=[57 (1413508475985592320)]} 0 3
[junit4:junit4]   2> 5372 T790 C88 P58159 /update {wt=javabin&version=2} {add=[58 (1413508475990835200)]} 0 0
[junit4:junit4]   2> 5377 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5377 T806 C87 P41562 /update {wt=javabin&version=2} {add=[58 (1413508475992932352)]} 0 3
[junit4:junit4]   2> 5379 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[45 (-1413508475998175232)]} 0 0
[junit4:junit4]   2> 5382 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5383 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[45 (-1413508476000272384)]} 0 2
[junit4:junit4]   2> 5385 T790 C88 P58159 /update {wt=javabin&version=2} {add=[59 (1413508476004466688)]} 0 0
[junit4:junit4]   2> 5390 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=17 
[junit4:junit4]   2> 5391 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10054 (1413508475989786624)]} 0 20
[junit4:junit4]   2> 5392 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5392 T806 C87 P41562 /update {wt=javabin&version=2} {add=[59 (1413508476006563840)]} 0 5
[junit4:junit4]   2> 5393 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10055 (1413508476012855296)]} 0 0
[junit4:junit4]   2> 5394 T791 C88 P58159 /update {wt=javabin&version=2} {add=[60 (1413508476013903872)]} 0 0
[junit4:junit4]   2> 5398 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5398 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10055 (1413508476014952448)]} 0 3
[junit4:junit4]   2> 5399 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5399 T807 C87 P41562 /update {wt=javabin&version=2} {add=[60 (1413508476016001024)]} 0 3
[junit4:junit4]   2> 5400 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[10042 (-1413508476020195328)]} 0 0
[junit4:junit4]   2> 5401 T790 C88 P58159 /update {wt=javabin&version=2} {add=[61 (1413508476021243904)]} 0 0
[junit4:junit4]   2> 5404 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5405 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[10042 (-1413508476022292480)]} 0 3
[junit4:junit4]   2> 5406 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5406 T806 C87 P41562 /update {wt=javabin&version=2} {add=[61 (1413508476023341056)]} 0 3
[junit4:junit4]   2> 5409 T791 C88 P58159 /update {wt=javabin&version=2} {add=[62 (1413508476028583937)]} 0 1
[junit4:junit4]   2> 5411 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10056 (1413508476028583936)]} 0 3
[junit4:junit4]   2> 5413 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5413 T806 C87 P41562 /update {wt=javabin&version=2} {add=[62 (1413508476031729664)]} 0 3
[junit4:junit4]   2> 5415 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5415 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10056 (1413508476033826816)]} 0 2
[junit4:junit4]   2> 5416 T790 C88 P58159 /update {wt=javabin&version=2} {add=[63 (1413508476035923968)]} 0 1
[junit4:junit4]   2> 5420 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[10044 (-1413508476041166848)]} 0 0
[junit4:junit4]   2> 5424 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5424 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5424 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10044 (-1413508476043264000)]} 0 2
[junit4:junit4]   2> 5424 T807 C87 P41562 /update {wt=javabin&version=2} {add=[63 (1413508476042215424)]} 0 3
[junit4:junit4]   2> 5426 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[48 (-1413508476047458305)]} 0 0
[junit4:junit4]   2> 5426 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10057 (1413508476047458304)]} 0 0
[junit4:junit4]   2> 5430 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5430 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[48 (-1413508476049555456)]} 0 2
[junit4:junit4]   2> 5430 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5431 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10057 (1413508476049555457)]} 0 3
[junit4:junit4]   2> 5433 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10058 (1413508476053749761)]} 0 1
[junit4:junit4]   2> 5435 T791 C88 P58159 /update {wt=javabin&version=2} {add=[64 (1413508476053749760)]} 0 3
[junit4:junit4]   2> 5439 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 5440 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5440 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10058 (1413508476056895488)]} 0 5
[junit4:junit4]   2> 5440 T807 C87 P41562 /update {wt=javabin&version=2} {add=[64 (1413508476058992640)]} 0 3
[junit4:junit4]   2> 5442 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[10045 (-1413508476064235520)]} 0 0
[junit4:junit4]   2> 5442 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[50 (-1413508476064235521)]} 0 0
[junit4:junit4]   2> 5445 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5445 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5446 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[10045 (-1413508476066332672)]} 0 3
[junit4:junit4]   2> 5446 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[50 (-1413508476066332673)]} 0 2
[junit4:junit4]   2> 5448 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10059 (1413508476070526976)]} 0 1
[junit4:junit4]   2> 5449 T791 C88 P58159 /update {wt=javabin&version=2} {add=[65 (1413508476070526977)]} 0 1
[junit4:junit4]   2> 5452 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5452 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10059 (1413508476072624128)]} 0 2
[junit4:junit4]   2> 5453 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5455 T807 C87 P41562 /update {wt=javabin&version=2} {add=[65 (1413508476073672704)]} 0 5
[junit4:junit4]   2> 5457 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[51 (-1413508476079964161)]} 0 0
[junit4:junit4]   2> 5458 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10060 (1413508476079964160)]} 0 1
[junit4:junit4]   2> 5462 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5462 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[51 (-1413508476083109888)]} 0 2
[junit4:junit4]   2> 5464 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5465 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10060 (1413508476084158464)]} 0 5
[junit4:junit4]   2> 5466 T791 C88 P58159 /update {wt=javabin&version=2} {add=[66 (1413508476088352768)]} 0 1
[junit4:junit4]   2> 5468 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10061 (1413508476090449920)]} 0 1
[junit4:junit4]   2> 5472 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5473 T806 C87 P41562 /update {wt=javabin&version=2} {add=[66 (1413508476092547072)]} 0 4
[junit4:junit4]   2> 5474 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5474 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10061 (1413508476094644224)]} 0 3
[junit4:junit4]   2> 5476 T790 C88 P58159 /update {wt=javabin&version=2} {add=[67 (1413508476098838528)]} 0 1
[junit4:junit4]   2> 5478 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10062 (1413508476100935680)]} 0 1
[junit4:junit4]   2> 5483 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5484 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10062 (1413508476105129984)]} 0 3
[junit4:junit4]   2> 5484 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5485 T807 C87 P41562 /update {wt=javabin&version=2} {add=[67 (1413508476101984256)]} 0 7
[junit4:junit4]   2> 5486 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10063 (1413508476109324288)]} 0 1
[junit4:junit4]   2> 5487 T790 C88 P58159 /update {wt=javabin&version=2} {add=[68 (1413508476110372864)]} 0 1
[junit4:junit4]   2> 5490 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5492 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10063 (1413508476112470016)]} 0 5
[junit4:junit4]   2> 5493 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10048 (-1413508476117712896)]} 0 0
[junit4:junit4]   2> 5496 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 5496 T806 C87 P41562 /update {wt=javabin&version=2} {add=[68 (1413508476113518592)]} 0 8
[junit4:junit4]   2> 5497 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5497 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[10048 (-1413508476119810048)]} 0 2
[junit4:junit4]   2> 5499 T790 C88 P58159 /update {wt=javabin&version=2} {add=[69 (1413508476122955776)]} 0 1
[junit4:junit4]   2> 5499 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10064 (1413508476124004352)]} 0 0
[junit4:junit4]   2> 5503 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5504 T807 C87 P41562 /update {wt=javabin&version=2} {add=[69 (1413508476126101504)]} 0 4
[junit4:junit4]   2> 5504 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5504 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10064 (1413508476126101505)]} 0 3
[junit4:junit4]   2> 5506 T791 C88 P58159 /update {wt=javabin&version=2} {add=[70 (1413508476131344384)]} 0 1
[junit4:junit4]   2> 5506 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10050 (-1413508476131344385)]} 0 0
[junit4:junit4]   2> 5510 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5510 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5511 T806 C87 P41562 /update {wt=javabin&version=2} {add=[70 (1413508476133441536)]} 0 3
[junit4:junit4]   2> 5512 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[10050 (-1413508476133441537)]} 0 4
[junit4:junit4]   2> 5513 T790 C88 P58159 /update {wt=javabin&version=2} {add=[71 (1413508476138684416)]} 0 0
[junit4:junit4]   2> 5515 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10065 (1413508476139732992)]} 0 1
[junit4:junit4]   2> 5518 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5518 T807 C87 P41562 /update {wt=javabin&version=2} {add=[71 (1413508476141830144)]} 0 2
[junit4:junit4]   2> 5519 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5519 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10065 (1413508476141830145)]} 0 3
[junit4:junit4]   2> 5521 T791 C88 P58159 /update {wt=javabin&version=2} {add=[72 (1413508476146024448)]} 0 1
[junit4:junit4]   2> 5521 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10051 (-1413508476147073024)]} 0 0
[junit4:junit4]   2> 5524 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5525 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5525 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[10051 (-1413508476149170176)]} 0 2
[junit4:junit4]   2> 5525 T806 C87 P41562 /update {wt=javabin&version=2} {add=[72 (1413508476148121600)]} 0 3
[junit4:junit4]   2> 5527 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10066 (1413508476153364480)]} 0 0
[junit4:junit4]   2> 5530 T791 C88 P58159 /update {wt=javabin&version=2} {add=[73 (1413508476153364481)]} 0 3
[junit4:junit4]   2> 5531 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5532 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10066 (1413508476155461632)]} 0 3
[junit4:junit4]   2> 5534 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5535 T807 C87 P41562 /update {wt=javabin&version=2} {add=[73 (1413508476158607360)]} 0 3
[junit4:junit4]   2> 5535 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10067 (1413508476160704512)]} 0 1
[junit4:junit4]   2> 5537 T791 C88 P58159 /update {wt=javabin&version=2} {add=[74 (1413508476162801664)]} 0 1
[junit4:junit4]   2> 5539 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5539 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10067 (1413508476162801664)]} 0 3
[junit4:junit4]   2> 5541 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10068 (1413508476168044544)]} 0 0
[junit4:junit4]   2> 5543 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 5544 T806 C87 P41562 /update {wt=javabin&version=2} {add=[74 (1413508476165947392)]} 0 6
[junit4:junit4]   2> 5548 T791 C88 P58159 /update {wt=javabin&version=2} {add=[75 (1413508476175384576)]} 0 3
[junit4:junit4]   2> 5549 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 5549 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10068 (1413508476170141696)]} 0 6
[junit4:junit4]   2> 5551 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10069 (1413508476178530304)]} 0 0
[junit4:junit4]   2> 5553 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5553 T806 C87 P41562 /update {wt=javabin&version=2} {add=[75 (1413508476177481728)]} 0 3
[junit4:junit4]   2> 5555 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[52 (-1413508476182724608)]} 0 0
[junit4:junit4]   2> 5555 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5556 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10069 (1413508476180627456)]} 0 3
[junit4:junit4]   2> 5558 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10070 (1413508476184821760)]} 0 1
[junit4:junit4]   2> 5558 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5559 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[52 (-1413508476184821760)]} 0 2
[junit4:junit4]   2> 5561 T791 C88 P58159 /update {wt=javabin&version=2} {add=[76 (1413508476187967488)]} 0 1
[junit4:junit4]   2> 5562 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5562 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10070 (1413508476187967488)]} 0 2
[junit4:junit4]   2> 5564 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10071 (1413508476192161792)]} 0 0
[junit4:junit4]   2> 5565 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5565 T806 C87 P41562 /update {wt=javabin&version=2} {add=[76 (1413508476191113216)]} 0 2
[junit4:junit4]   2> 5568 T791 C88 P58159 /update {wt=javabin&version=2} {add=[77 (1413508476195307520)]} 0 1
[junit4:junit4]   2> 5568 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5569 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10071 (1413508476194258944)]} 0 3
[junit4:junit4]   2> 5572 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5572 T806 C87 P41562 /update {wt=javabin&version=2} {add=[77 (1413508476197404672)]} 0 3
[junit4:junit4]   2> 5574 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10072 (1413508476199501824)]} 0 3
[junit4:junit4]   2> 5581 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5582 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10072 (1413508476204744704)]} 0 6
[junit4:junit4]   2> 5584 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10073 (1413508476213133312)]} 0 1
[junit4:junit4]   2> 5589 T790 C88 P58159 /update {wt=javabin&version=2} {add=[78 (1413508476202647552)]} 0 15
[junit4:junit4]   2> 5590 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5590 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10073 (1413508476216279040)]} 0 4
[junit4:junit4]   2> 5593 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10074 (1413508476221521920)]} 0 1
[junit4:junit4]   2> 5600 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 5601 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10074 (1413508476224667648)]} 0 6
[junit4:junit4]   2> 5603 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10075 (1413508476233056256)]} 0 1
[junit4:junit4]   2> 5612 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=5 
[junit4:junit4]   2> 5612 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10075 (1413508476235153408)]} 0 7
[junit4:junit4]   2> 5614 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10052 (-1413508476244590592)]} 0 0
[junit4:junit4]   2> 5618 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5618 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10052 (-1413508476246687744)]} 0 2
[junit4:junit4]   2> 5620 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5620 T807 C87 P41562 /update {wt=javabin&version=2} {add=[78 (1413508476220473344)]} 0 29
[junit4:junit4]   2> 5621 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10076 (1413508476250882048)]} 0 1
[junit4:junit4]   2> 5622 T791 C88 P58159 /update {wt=javabin&version=2} {add=[79 (1413508476252979200)]} 0 0
[junit4:junit4]   2> 5625 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5626 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10076 (1413508476254027776)]} 0 4
[junit4:junit4]   2> 5626 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5627 T806 C87 P41562 /update {wt=javabin&version=2} {add=[79 (1413508476255076352)]} 0 3
[junit4:junit4]   2> 5629 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10077 (1413508476259270656)]} 0 1
[junit4:junit4]   2> 5630 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[53 (-1413508476260319232)]} 0 1
[junit4:junit4]   2> 5633 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5634 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[53 (-1413508476263464960)]} 0 3
[junit4:junit4]   2> 5634 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5634 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10077 (1413508476262416384)]} 0 3
[junit4:junit4]   2> 5636 T790 C88 P58159 /update {wt=javabin&version=2} {add=[80 (1413508476267659264)]} 0 0
[junit4:junit4]   2> 5637 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10078 (1413508476267659265)]} 0 1
[junit4:junit4]   2> 5640 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5641 T806 C87 P41562 /update {wt=javabin&version=2} {add=[80 (1413508476269756416)]} 0 3
[junit4:junit4]   2> 5641 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5641 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10078 (1413508476270804992)]} 0 2
[junit4:junit4]   2> 5643 T791 C88 P58159 /update {wt=javabin&version=2} {add=[81 (1413508476273950720)]} 0 1
[junit4:junit4]   2> 5644 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10079 (1413508476274999296)]} 0 1
[junit4:junit4]   2> 5647 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5647 T807 C87 P41562 /update {wt=javabin&version=2} {add=[81 (1413508476277096448)]} 0 2
[junit4:junit4]   2> 5648 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5648 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10079 (1413508476277096449)]} 0 3
[junit4:junit4]   2> 5649 T790 C88 P58159 /update {wt=javabin&version=2} {add=[82 (1413508476281290752)]} 0 0
[junit4:junit4]   2> 5650 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[10053 (-1413508476282339328)]} 0 0
[junit4:junit4]   2> 5653 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5654 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[10053 (-1413508476284436480)]} 0 2
[junit4:junit4]   2> 5656 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10080 (1413508476288630784)]} 0 0
[junit4:junit4]   2> 5656 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 5657 T806 C87 P41562 /update {wt=javabin&version=2} {add=[82 (1413508476283387904)]} 0 6
[junit4:junit4]   2> 5659 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[56 (-1413508476291776512)]} 0 0
[junit4:junit4]   2> 5661 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5661 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10080 (1413508476290727936)]} 0 3
[junit4:junit4]   2> 5662 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5662 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[56 (-1413508476292825088)]} 0 2
[junit4:junit4]   2> 5663 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10081 (1413508476295970816)]} 0 0
[junit4:junit4]   2> 5664 T790 C88 P58159 /update {wt=javabin&version=2} {add=[83 (1413508476297019392)]} 0 0
[junit4:junit4]   2> 5667 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5667 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10081 (1413508476298067968)]} 0 2
[junit4:junit4]   2> 5668 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5669 T807 C87 P41562 /update {wt=javabin&version=2} {add=[83 (1413508476299116544)]} 0 3
[junit4:junit4]   2> 5670 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10082 (1413508476302262272)]} 0 1
[junit4:junit4]   2> 5671 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[57 (-1413508476304359424)]} 0 0
[junit4:junit4]   2> 5673 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5674 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10082 (1413508476304359424)]} 0 3
[junit4:junit4]   2> 5674 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5674 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[57 (-1413508476305408000)]} 0 2
[junit4:junit4]   2> 5676 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[10056 (-1413508476309602304)]} 0 1
[junit4:junit4]   2> 5676 T790 C88 P58159 /update {wt=javabin&version=2} {add=[84 (1413508476309602305)]} 0 0
[junit4:junit4]   2> 5679 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5679 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10056 (-1413508476310650880)]} 0 2
[junit4:junit4]   2> 5681 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5681 T807 C87 P41562 /update {wt=javabin&version=2} {add=[84 (1413508476311699456)]} 0 3
[junit4:junit4]   2> 5685 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[58 (-1413508476317990912)]} 0 1
[junit4:junit4]   2> 5685 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10083 (1413508476314845184)]} 0 4
[junit4:junit4]   2> 5688 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5689 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[58 (-1413508476321136640)]} 0 3
[junit4:junit4]   2> 5695 T790 C88 P58159 /update {wt=javabin&version=2} {add=[85 (1413508476324282368)]} 0 5
[junit4:junit4]   2> 5695 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5696 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10083 (1413508476321136641)]} 0 9
[junit4:junit4]   2> 5697 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10057 (-1413508476331622400)]} 0 0
[junit4:junit4]   2> 5699 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5700 T807 C87 P41562 /update {wt=javabin&version=2} {add=[85 (1413508476331622400)]} 0 3
[junit4:junit4]   2> 5701 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5701 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10057 (-1413508476333719552)]} 0 2
[junit4:junit4]   2> 5702 T790 C88 P58159 /update {wt=javabin&version=2} {add=[86 (1413508476335816704)]} 0 1
[junit4:junit4]   2> 5704 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10084 (1413508476337913856)]} 0 1
[junit4:junit4]   2> 5706 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5707 T806 C87 P41562 /update {wt=javabin&version=2} {add=[86 (1413508476337913856)]} 0 4
[junit4:junit4]   2> 5708 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5708 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10084 (1413508476341059584)]} 0 3
[junit4:junit4]   2> 5709 T791 C88 P58159 /update {wt=javabin&version=2} {add=[87 (1413508476343156736)]} 0 1
[junit4:junit4]   2> 5710 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10058 (-1413508476345253888)]} 0 0
[junit4:junit4]   2> 5713 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5714 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10058 (-1413508476347351040)]} 0 2
[junit4:junit4]   2> 5716 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10085 (1413508476350496768)]} 0 1
[junit4:junit4]   2> 5718 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 5719 T807 C87 P41562 /update {wt=javabin&version=2} {add=[87 (1413508476346302464)]} 0 8
[junit4:junit4]   2> 5720 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5720 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[59 (-1413508476355739648)]} 0 0
[junit4:junit4]   2> 5721 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10085 (1413508476352593920)]} 0 4
[junit4:junit4]   2> 5723 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10086 (1413508476357836800)]} 0 1
[junit4:junit4]   2> 5724 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5724 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[59 (-1413508476357836800)]} 0 2
[junit4:junit4]   2> 5727 T790 C88 P58159 /update {wt=javabin&version=2} {add=[88 (1413508476362031104)]} 0 1
[junit4:junit4]   2> 5727 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5727 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10086 (1413508476360982528)]} 0 2
[junit4:junit4]   2> 5730 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10087 (1413508476365176832)]} 0 1
[junit4:junit4]   2> 5731 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5732 T807 C87 P41562 /update {wt=javabin&version=2} {add=[88 (1413508476364128256)]} 0 4
[junit4:junit4]   2> 5734 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5734 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[60 (-1413508476370419712)]} 0 0
[junit4:junit4]   2> 5734 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10087 (1413508476367273984)]} 0 3
[junit4:junit4]   2> 5736 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10059 (-1413508476372516864)]} 0 0
[junit4:junit4]   2> 5737 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5738 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[60 (-1413508476372516864)]} 0 2
[junit4:junit4]   2> 5739 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5739 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10059 (-1413508476374614016)]} 0 2
[junit4:junit4]   2> 5740 T790 C88 P58159 /update {wt=javabin&version=2} {add=[89 (1413508476375662592)]} 0 1
[junit4:junit4]   2> 5744 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5744 T806 C87 P41562 /update {wt=javabin&version=2} {add=[89 (1413508476378808320)]} 0 3
[junit4:junit4]   2> 5746 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10088 (1413508476377759744)]} 0 5
[junit4:junit4]   2> 5746 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[63 (-1413508476383002624)]} 0 0
[junit4:junit4]   2> 5750 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5750 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5750 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[63 (-1413508476385099777)]} 0 2
[junit4:junit4]   2> 5750 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10088 (1413508476385099776)]} 0 2
[junit4:junit4]   2> 5752 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[10060 (-1413508476389294081)]} 0 0
[junit4:junit4]   2> 5752 T790 C88 P58159 /update {wt=javabin&version=2} {add=[90 (1413508476389294080)]} 0 0
[junit4:junit4]   2> 5756 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5756 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10060 (-1413508476391391232)]} 0 2
[junit4:junit4]   2> 5757 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5757 T807 C87 P41562 /update {wt=javabin&version=2} {add=[90 (1413508476391391233)]} 0 3
[junit4:junit4]   2> 5759 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10089 (1413508476395585536)]} 0 1
[junit4:junit4]   2> 5760 T791 C88 P58159 /update {wt=javabin&version=2} {add=[91 (1413508476396634112)]} 0 1
[junit4:junit4]   2> 5762 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5763 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10089 (1413508476397682688)]} 0 3
[junit4:junit4]   2> 5764 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5765 T806 C87 P41562 /update {wt=javabin&version=2} {add=[91 (1413508476399779840)]} 0 3
[junit4:junit4]   2> 5765 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[10063 (-1413508476402925568)]} 0 0
[junit4:junit4]   2> 5768 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5769 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10063 (-1413508476405022720)]} 0 2
[junit4:junit4]   2> 5769 T790 C88 P58159 /update {wt=javabin&version=2} {add=[92 (1413508476403974144)]} 0 3
[junit4:junit4]   2> 5771 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10090 (1413508476409217024)]} 0 1
[junit4:junit4]   2> 5776 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5776 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10090 (1413508476411314176)]} 0 3
[junit4:junit4]   2> 5778 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10091 (1413508476416557056)]} 0 0
[junit4:junit4]   2> 5782 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5783 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10091 (1413508476418654208)]} 0 3
[junit4:junit4]   2> 5785 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10092 (1413508476422848512)]} 0 1
[junit4:junit4]   2> 5787 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=14 
[junit4:junit4]   2> 5788 T806 C87 P41562 /update {wt=javabin&version=2} {add=[92 (1413508476409217024)]} 0 17
[junit4:junit4]   2> 5789 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5789 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10092 (1413508476425994240)]} 0 2
[junit4:junit4]   2> 5790 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[65 (-1413508476429139968)]} 0 0
[junit4:junit4]   2> 5791 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10065 (-1413508476430188544)]} 0 0
[junit4:junit4]   2> 5796 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5797 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[65 (-1413508476430188544)]} 0 6
[junit4:junit4]   2> 5798 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5798 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10065 (-1413508476435431424)]} 0 2
[junit4:junit4]   2> 5800 T790 C88 P58159 /update {wt=javabin&version=2} {add=[93 (1413508476438577152)]} 0 1
[junit4:junit4]   2> 5801 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10093 (1413508476439625728)]} 0 1
[junit4:junit4]   2> 5804 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5805 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5805 T806 C87 P41562 /update {wt=javabin&version=2} {add=[93 (1413508476441722880)]} 0 3
[junit4:junit4]   2> 5805 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10093 (1413508476441722881)]} 0 3
[junit4:junit4]   2> 5807 T791 C88 P58159 /update {wt=javabin&version=2} {add=[94 (1413508476446965760)]} 0 0
[junit4:junit4]   2> 5808 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10094 (1413508476446965761)]} 0 1
[junit4:junit4]   2> 5812 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5812 T807 C87 P41562 /update {wt=javabin&version=2} {add=[94 (1413508476449062912)]} 0 3
[junit4:junit4]   2> 5814 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[67 (-1413508476454305792)]} 0 0
[junit4:junit4]   2> 5815 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5815 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10094 (1413508476450111488)]} 0 5
[junit4:junit4]   2> 5817 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10067 (-1413508476457451520)]} 0 0
[junit4:junit4]   2> 5817 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5818 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[67 (-1413508476456402944)]} 0 2
[junit4:junit4]   2> 5820 T790 C88 P58159 /update {wt=javabin&version=2} {add=[95 (1413508476459548672)]} 0 1
[junit4:junit4]   2> 5820 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5821 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10067 (-1413508476459548672)]} 0 2
[junit4:junit4]   2> 5823 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10095 (1413508476463742976)]} 0 1
[junit4:junit4]   2> 5824 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5824 T807 C87 P41562 /update {wt=javabin&version=2} {add=[95 (1413508476462694400)]} 0 2
[junit4:junit4]   2> 5826 T790 C88 P58159 /update {wt=javabin&version=2} {add=[96 (1413508476466888704)]} 0 0
[junit4:junit4]   2> 5827 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5828 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10095 (1413508476465840128)]} 0 4
[junit4:junit4]   2> 5830 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10096 (1413508476470034432)]} 0 1
[junit4:junit4]   2> 5834 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5835 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10096 (1413508476473180160)]} 0 4
[junit4:junit4]   2> 5836 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 5836 T807 C87 P41562 /update {wt=javabin&version=2} {add=[96 (1413508476468985856)]} 0 8
[junit4:junit4]   2> 5837 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10097 (1413508476478423040)]} 0 0
[junit4:junit4]   2> 5838 T791 C88 P58159 /update {wt=javabin&version=2} {add=[97 (1413508476479471616)]} 0 0
[junit4:junit4]   2> 5842 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5843 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5844 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10097 (1413508476480520192)]} 0 5
[junit4:junit4]   2> 5844 T806 C87 P41562 /update {wt=javabin&version=2} {add=[97 (1413508476481568768)]} 0 4
[junit4:junit4]   2> 5846 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10068 (-1413508476487860224)]} 0 0
[junit4:junit4]   2> 5846 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[68 (-1413508476487860225)]} 0 0
[junit4:junit4]   2> 5849 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5849 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5850 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[68 (-1413508476489957377)]} 0 2
[junit4:junit4]   2> 5850 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[10068 (-1413508476489957376)]} 0 2
[junit4:junit4]   2> 5852 T791 C88 P58159 /update {wt=javabin&version=2} {add=[98 (1413508476494151680)]} 0 0
[junit4:junit4]   2> 5852 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10098 (1413508476494151681)]} 0 0
[junit4:junit4]   2> 5856 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5856 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5857 T806 C87 P41562 /update {wt=javabin&version=2} {add=[98 (1413508476496248833)]} 0 3
[junit4:junit4]   2> 5857 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10098 (1413508476496248832)]} 0 3
[junit4:junit4]   2> 5859 T790 C88 P58159 /update {wt=javabin&version=2} {add=[99 (1413508476500443136)]} 0 1
[junit4:junit4]   2> 5859 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10099 (1413508476501491712)]} 0 0
[junit4:junit4]   2> 5863 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5863 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5863 T807 C87 P41562 /update {wt=javabin&version=2} {add=[99 (1413508476503588864)]} 0 2
[junit4:junit4]   2> 5864 T806 C87 P41562 /update {wt=javabin&version=2} {add=[10099 (1413508476503588865)]} 0 3
[junit4:junit4]   2> 5865 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[69 (-1413508476507783168)]} 0 0
[junit4:junit4]   2> 5865 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10069 (-1413508476507783169)]} 0 0
[junit4:junit4]   2> 5869 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5869 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5869 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[69 (-1413508476509880320)]} 0 2
[junit4:junit4]   2> 5869 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[10069 (-1413508476509880321)]} 0 2
[junit4:junit4]   2> 5875 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10100 (1413508476514074625)]} 0 4
[junit4:junit4]   2> 5876 T790 C88 P58159 /update {wt=javabin&version=2} {add=[100 (1413508476514074624)]} 0 5
[junit4:junit4]   2> 5879 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5880 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10100 (1413508476520366080)]} 0 3
[junit4:junit4]   2> 5881 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5881 T806 C87 P41562 /update {wt=javabin&version=2} {add=[100 (1413508476521414656)]} 0 3
[junit4:junit4]   2> 5882 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[10071 (-1413508476525608960)]} 0 0
[junit4:junit4]   2> 5883 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[71 (-1413508476526657536)]} 0 0
[junit4:junit4]   2> 5888 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5888 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10071 (-1413508476529803264)]} 0 2
[junit4:junit4]   2> 5889 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5889 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[71 (-1413508476530851840)]} 0 2
[junit4:junit4]   2> 5895 T791 C88 P58159 /update {wt=javabin&version=2} {add=[10101 (1413508476533997568)]} 0 5
[junit4:junit4]   2> 5896 T790 C88 P58159 /update {wt=javabin&version=2} {add=[101 (1413508476539240448)]} 0 1
[junit4:junit4]   2> 5900 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5901 T806 C87 P41562 /update {wt=javabin&version=2} {add=[101 (1413508476542386176)]} 0 3
[junit4:junit4]   2> 5902 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 5902 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10101 (1413508476541337600)]} 0 5
[junit4:junit4]   2> 5903 T790 C88 P58159 /update {wt=javabin&version=2} {delete=[73 (-1413508476547629056)]} 0 0
[junit4:junit4]   2> 5904 T791 C88 P58159 /update {wt=javabin&version=2} {delete=[10073 (-1413508476548677632)]} 0 0
[junit4:junit4]   2> 5906 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5907 T807 C87 P41562 /update {wt=javabin&version=2} {delete=[73 (-1413508476549726208)]} 0 2
[junit4:junit4]   2> 5907 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5908 T806 C87 P41562 /update {wt=javabin&version=2} {delete=[10073 (-1413508476550774784)]} 0 2
[junit4:junit4]   2> 5909 T791 C88 P58159 /update {wt=javabin&version=2} {add=[102 (1413508476552871936)]} 0 1
[junit4:junit4]   2> 5910 T790 C88 P58159 /update {wt=javabin&version=2} {add=[10102 (1413508476554969088)]} 0 0
[junit4:junit4]   2> 5913 T817 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5913 T806 C87 P41562 /update {wt=javabin&version=2} {add=[102 (1413508476556017664)]} 0 2
[junit4:junit4]   2> 5914 T816 C86 P47109 REQ /update {distrib.from=http://127.0.0.1:41562/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5914 T807 C87 P41562 /update {wt=javabin&version=2} {add=[10102 (1413508476557066240)]} 0 2
[junit4:junit4]   2> 5915 T790 C88 P58159 /update {wt=javabin&version=2} {add=[

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

entCnxn$SendThread.run WARNING Session 0x139dca76f750007 for server null, unexpected error, closing socket connection and attempting reconnect java.net.ConnectException: Connection refused
[junit4:junit4]   2> 	at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method)
[junit4:junit4]   2> 	at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:599)
[junit4:junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1143)
[junit4:junit4]   2> 
[junit4:junit4]   2> 23924 T811 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost.localdomain/127.0.0.1:47930
[junit4:junit4]   2> 24025 T812 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 24025 T778 oaz.ZooKeeper.close Session: 0x139dca76f750003 closed
[junit4:junit4]   2> 24027 T778 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 24078 T778 oasc.ChaosMonkey.monkeyLog monkey: stop shard! 47109
[junit4:junit4]   2> 24078 T778 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=8900716
[junit4:junit4]   2> 25352 T949 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost.localdomain/127.0.0.1:47930
[junit4:junit4]   2> 25453 T950 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 25453 T778 oaz.ZooKeeper.close Session: 0x139dca76f750007 closed
[junit4:junit4]   2> 25454 T778 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 25547 T778 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=RecoveryZkTest -Dtests.method=testDistribSearch -Dtests.seed=E1B392627CF62553 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sk -Dtests.timezone=Jamaica -Dtests.file.encoding=UTF-8
[junit4:junit4] ERROR   25.6s J1 | RecoveryZkTest.testDistribSearch <<<
[junit4:junit4]    > Throwable #1: org.apache.solr.common.SolrException: Server at http://127.0.0.1:47109/solr/collection1 returned non ok status:404, message:Can not find: /solr/collection1/select
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([E1B392627CF62553:60551C7A0BA9456F]:0)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:373)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:182)
[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:324)
[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:39)
[junit4:junit4]    > 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
[junit4:junit4]    > 	at java.lang.reflect.Method.invoke(Method.java:597)
[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:662)
[junit4:junit4]   2> 25610 T778 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4]   2> NOTE: test params are: codec=Appending, sim=DefaultSimilarity, locale=sk, timezone=Jamaica
[junit4:junit4]   2> NOTE: Linux 3.2.0-30-generic i386/Sun Microsystems Inc. 1.6.0_35 (32-bit)/cpus=8,threads=1,free=76037184,total=129761280
[junit4:junit4]   2> NOTE: All tests run in this JVM: [TestSolrDeletionPolicy1, DirectUpdateHandlerTest, IndexSchemaRuntimeFieldTest, OpenExchangeRatesOrgProviderTest, StatelessScriptUpdateProcessorFactoryTest, MultiTermTest, TestReload, TestDocSet, TestCharFilters, TestQueryUtils, TestTrie, PolyFieldTest, DocumentBuilderTest, TestFunctionQuery, TestMergePolicyConfig, QueryParsingTest, ReturnFieldsTest, TestDocumentBuilder, TestSolrXMLSerializer, FieldMutatingUpdateProcessorTest, ShowFileRequestHandlerTest, BasicDistributedZk2Test, SoftAutoCommitTest, URLClassifyProcessorTest, TestSort, TestValueSourceCache, LeaderElectionTest, ZkNodePropsTest, DirectSolrSpellCheckerTest, BadIndexSchemaTest, PathHierarchyTokenizerFactoryTest, TestUpdate, FileUtilsTest, LegacyHTMLStripCharFilterTest, DebugComponentTest, LukeRequestHandlerTest, ZkSolrClientTest, TestJmxIntegration, UUIDFieldTest, FullSolrCloudDistribCmdsTest, TestUtils, TestCSVLoader, DistributedQueryElevationComponentTest, RecoveryZkTest]
[junit4:junit4] Completed on J1 in 25.64s, 1 test, 1 error <<< FAILURES!

[...truncated 415 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:32: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:146: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/module-build.xml:63: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1136: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:810: There were test failures: 230 suites, 950 tests, 1 error, 7 ignored (2 assumptions)

Total time: 23 minutes 43 seconds
Build step 'Invoke Ant' marked build as failure
Recording test results
Description set: Java: 32bit/jdk1.6.0_35 -client -XX:+UseConcMarkSweepGC
Email was triggered for: Failure
Sending email for trigger: Failure



Mime
View raw message