lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Jenkins Server <jenk...@builds.apache.org>
Subject [JENKINS] Lucene-Solr-Tests-trunk-java7 - Build # 3279 - Failure
Date Sat, 06 Oct 2012 10:12:32 GMT
Build: https://builds.apache.org/job/Lucene-Solr-Tests-trunk-java7/3279/

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

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




Build Log:
[...truncated 8702 lines...]
[junit4:junit4] Suite: org.apache.solr.cloud.RecoveryZkTest
[junit4:junit4]   2> 5 T571 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4:junit4]   2> Creating dataDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./solrtest-RecoveryZkTest-1349517896436
[junit4:junit4]   2> 6 T571 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4]   2> 9 T572 oazs.ZooKeeperServer.setTickTime tickTime set to 1000
[junit4:junit4]   2> 9 T572 oazs.NIOServerCnxn$Factory.<init> binding to port 0.0.0.0/0.0.0.0:0
[junit4:junit4]   2> 10 T572 oazsp.FileTxnSnapLog.save Snapshotting: 0
[junit4:junit4]   2> 108 T571 oasc.ZkTestServer.run start zk server on port:35318
[junit4:junit4]   2> 108 T571 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:35318 sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@1e127923
[junit4:junit4]   2> 109 T577 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:35318
[junit4:junit4]   2> 109 T571 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 110 T577 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost/127.0.0.1:35318, initiating session
[junit4:junit4]   2> 111 T573 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /140.211.11.196:35319
[junit4:junit4]   2> 111 T573 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /140.211.11.196:35319
[junit4:junit4]   2> 112 T575 oazsp.FileTxnLog.append Creating new log file: log.1
[junit4:junit4]   2> 114 T575 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a3588eaf90000 with negotiated timeout 10000 for client /140.211.11.196:35319
[junit4:junit4]   2> 114 T577 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost/127.0.0.1:35318, sessionid = 0x13a3588eaf90000, negotiated timeout = 10000
[junit4:junit4]   2> 114 T578 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1e127923 name:ZooKeeperConnection Watcher:127.0.0.1:35318 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 114 T571 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 115 T571 oascc.SolrZkClient.makePath makePath: /solr
[junit4:junit4]   2> 117 T576 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13a3588eaf90000
[junit4:junit4]   2> 118 T578 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 118 T571 oaz.ZooKeeper.close Session: 0x13a3588eaf90000 closed
[junit4:junit4]   2> 118 T573 oazs.NIOServerCnxn.closeSock Closed socket connection for client /140.211.11.196:35319 which had sessionid 0x13a3588eaf90000
[junit4:junit4]   2> 119 T571 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:35318/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@295e4cd9
[junit4:junit4]   2> 119 T579 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:35318
[junit4:junit4]   2> 119 T571 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 120 T579 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost/127.0.0.1:35318, initiating session
[junit4:junit4]   2> 121 T573 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /140.211.11.196:35320
[junit4:junit4]   2> 121 T573 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /140.211.11.196:35320
[junit4:junit4]   2> 122 T575 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a3588eaf90001 with negotiated timeout 10000 for client /140.211.11.196:35320
[junit4:junit4]   2> 122 T579 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost/127.0.0.1:35318, sessionid = 0x13a3588eaf90001, negotiated timeout = 10000
[junit4:junit4]   2> 123 T580 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@295e4cd9 name:ZooKeeperConnection Watcher:127.0.0.1:35318/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 123 T571 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 123 T571 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4:junit4]   2> 127 T571 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4:junit4]   2> 129 T571 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4:junit4]   2> 131 T571 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4:junit4]   2> 134 T571 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 135 T571 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 140 T571 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4:junit4]   2> 141 T571 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4:junit4]   2> 245 T571 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 246 T571 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 249 T571 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4:junit4]   2> 250 T571 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
[junit4:junit4]   2> 258 T571 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4:junit4]   2> 258 T571 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
[junit4:junit4]   2> 262 T571 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4:junit4]   2> 263 T571 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
[junit4:junit4]   2> 266 T571 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 266 T571 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 269 T571 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 270 T571 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 273 T571 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 274 T571 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 277 T571 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4:junit4]   2> 277 T571 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
[junit4:junit4]   2> 284 T576 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13a3588eaf90001
[junit4:junit4]   2> 285 T580 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 285 T571 oaz.ZooKeeper.close Session: 0x13a3588eaf90001 closed
[junit4:junit4]   2> 286 T573 oazs.NIOServerCnxn.closeSock Closed socket connection for client /140.211.11.196:35320 which had sessionid 0x13a3588eaf90001
[junit4:junit4]   2> 388 T571 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 392 T571 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:35321
[junit4:junit4]   2> 393 T571 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 393 T571 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1349517896716
[junit4:junit4]   2> 393 T571 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1349517896716/'
[junit4:junit4]   2> 432 T571 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 433 T571 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 433 T571 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1349517896716
[junit4:junit4]   2> 434 T571 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1349517896716/solr.xml
[junit4:junit4]   2> 434 T571 oasc.CoreContainer.<init> New CoreContainer 218392750
[junit4:junit4]   2> 435 T571 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1349517896716/'
[junit4:junit4]   2> 436 T571 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1349517896716/'
[junit4:junit4]   2> 468 T571 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 483 T571 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:35318/solr
[junit4:junit4]   2> 484 T571 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:35318/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@72f197bb
[junit4:junit4]   2> 485 T590 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:35318
[junit4:junit4]   2> 485 T571 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 487 T590 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost/127.0.0.1:35318, initiating session
[junit4:junit4]   2> 487 T573 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /140.211.11.196:35323
[junit4:junit4]   2> 487 T573 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /140.211.11.196:35323
[junit4:junit4]   2> 489 T575 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a3588eaf90002 with negotiated timeout 5000 for client /140.211.11.196:35323
[junit4:junit4]   2> 489 T590 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost/127.0.0.1:35318, sessionid = 0x13a3588eaf90002, negotiated timeout = 5000
[junit4:junit4]   2> 490 T591 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@72f197bb name:ZooKeeperConnection Watcher:127.0.0.1:35318/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 490 T571 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 492 T576 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a3588eaf90002 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 499 T571 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4:junit4]   2> 502 T571 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:35321_solr
[junit4:junit4]   2> 502 T576 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a3588eaf90002 type:delete cxid:0x7 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:35321_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:35321_solr
[junit4:junit4]   2> 504 T571 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:35321_solr
[junit4:junit4]   2> 507 T571 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 508 T571 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 508 T571 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 509 T571 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 509 T571 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 510 T571 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 510 T571 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 511 T571 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 512 T571 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 512 T571 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 530 T571 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4:junit4]   2> 556 T576 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a3588eaf90002 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> 558 T571 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4]   2> 560 T571 oasc.Overseer.start Overseer (id=88442004861157378-127.0.0.1:35321_solr-n_0000000000) starting
[junit4:junit4]   2> 561 T576 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a3588eaf90002 type:create cxid:0x1a zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 562 T576 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a3588eaf90002 type:create cxid:0x1b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 564 T576 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a3588eaf90002 type:create cxid:0x1c zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 565 T576 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a3588eaf90002 type:create cxid:0x1d zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 566 T593 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
[junit4:junit4]   2> 566 T571 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4:junit4]   2> 570 T571 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 572 T592 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4]   2> 576 T571 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1349517896716/collection1
[junit4:junit4]   2> 577 T571 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection
[junit4:junit4]   2> 578 T571 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 578 T571 oasc.ZkController.readConfigName Load collection config from:/collections/control_collection
[junit4:junit4]   2> 580 T571 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1349517896716/collection1/'
[junit4:junit4]   2> 582 T571 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-controljetty-1349517896716/collection1/lib/README' to classloader
[junit4:junit4]   2> 582 T571 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-controljetty-1349517896716/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 634 T571 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 705 T571 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 807 T571 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 814 T571 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 1428 T571 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 1438 T571 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 1443 T571 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 1457 T571 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 1462 T571 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 1466 T571 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 1468 T571 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 1470 T571 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1349517896716/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1349517896435/control/data/
[junit4:junit4]   2> 1470 T571 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6538b0f9
[junit4:junit4]   2> 1503 T571 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1349517896435/control/data/index/
[junit4:junit4]   2> 1505 T571 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1349517896435/control/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 1506 T571 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-1349517896435/control/data/index forceNew:false
[junit4:junit4]   2> 1514 T571 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1349517896435/control/data/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 1514 T571 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 1515 T571 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 1518 T571 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 1518 T571 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 1519 T571 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 1520 T571 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 1521 T571 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 1521 T571 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 1522 T571 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 1523 T571 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 1523 T571 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 1524 T571 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 1525 T571 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 1526 T571 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 1526 T571 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 1527 T571 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 1528 T571 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 1528 T571 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 1529 T571 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1530 T571 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1530 T571 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1531 T571 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1532 T571 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1533 T571 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1533 T571 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1534 T571 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 1535 T571 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 1547 T571 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 1551 T571 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 1553 T571 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> 1557 T571 oass.SolrIndexSearcher.<init> Opening Searcher@3255e9ce main
[junit4:junit4]   2> 1558 T571 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 1559 T571 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 1560 T571 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 1576 T571 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 1629 T594 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3255e9ce main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 1635 T576 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a3588eaf90002 type:create cxid:0x56 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer/queue Error:KeeperErrorCode = NoNode for /solr/overseer/queue
[junit4:junit4]   2> 1646 T571 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 1647 T571 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:35321/solr shardId:control_shard
[junit4:junit4]   2> 1648 T571 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/control_shard/election
[junit4:junit4]   2> 1666 T576 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a3588eaf90002 type:delete cxid:0x65 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> 1667 T571 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 1668 T576 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a3588eaf90002 type:create cxid:0x66 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2079 T592 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2081 T576 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a3588eaf90002 type:create cxid:0x6d zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer/queue-work Error:KeeperErrorCode = NoNode for /solr/overseer/queue-work
[junit4:junit4]   2> 2107 T591 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 2170 T571 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4]   2> 2171 T571 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 2171 T571 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:35321/solr/collection1/
[junit4:junit4]   2> 2172 T571 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4:junit4]   2> 2173 T571 oasc.SyncStrategy.syncToMe http://127.0.0.1:35321/solr/collection1/ has no replicas
[junit4:junit4]   2> 2173 T571 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:35321/solr/collection1/
[junit4:junit4]   2> 2174 T571 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/control_shard
[junit4:junit4]   2> 2178 T576 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a3588eaf90002 type:create cxid:0x8b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2614 T592 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2619 T591 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 2645 T571 oasc.ZkController.register We are http://127.0.0.1:35321/solr/collection1/ and leader is http://127.0.0.1:35321/solr/collection1/
[junit4:junit4]   2> 2645 T571 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:35321/solr
[junit4:junit4]   2> 2646 T571 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4]   2> 2648 T571 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2649 T571 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1
[junit4:junit4]   2> 2650 T571 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 2650 T571 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 2821 T571 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 2825 T571 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:35338
[junit4:junit4]   2> 2826 T571 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 2826 T571 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1349517899097
[junit4:junit4]   2> 2827 T571 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1349517899097/'
[junit4:junit4]   2> 2868 T571 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 2869 T571 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 2869 T571 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1349517899097
[junit4:junit4]   2> 2870 T571 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1349517899097/solr.xml
[junit4:junit4]   2> 2870 T571 oasc.CoreContainer.<init> New CoreContainer 654393099
[junit4:junit4]   2> 2871 T571 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1349517899097/'
[junit4:junit4]   2> 2872 T571 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1349517899097/'
[junit4:junit4]   2> 2904 T571 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 2919 T571 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:35318/solr
[junit4:junit4]   2> 2920 T571 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:35318/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@75c08e4
[junit4:junit4]   2> 2921 T604 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:35318
[junit4:junit4]   2> 2921 T571 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 2923 T604 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost/127.0.0.1:35318, initiating session
[junit4:junit4]   2> 2923 T573 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /140.211.11.196:35339
[junit4:junit4]   2> 2924 T573 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /140.211.11.196:35339
[junit4:junit4]   2> 2926 T575 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a3588eaf90003 with negotiated timeout 5000 for client /140.211.11.196:35339
[junit4:junit4]   2> 2926 T604 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost/127.0.0.1:35318, sessionid = 0x13a3588eaf90003, negotiated timeout = 5000
[junit4:junit4]   2> 2927 T605 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@75c08e4 name:ZooKeeperConnection Watcher:127.0.0.1:35318/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 2927 T571 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 2928 T576 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a3588eaf90003 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2940 T576 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a3588eaf90003 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2942 T571 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:35338_solr
[junit4:junit4]   2> 2942 T576 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a3588eaf90003 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:35338_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:35338_solr
[junit4:junit4]   2> 2944 T571 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:35338_solr
[junit4:junit4]   2> 2946 T591 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 2947 T571 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 2948 T571 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 2948 T571 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 2949 T571 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 2949 T571 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 2950 T571 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 2951 T571 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 2951 T571 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 2952 T571 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 2952 T571 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 2972 T571 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 2978 T571 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1349517899097/collection1
[junit4:junit4]   2> 2979 T571 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 2980 T571 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 2980 T571 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 2982 T571 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1349517899097/collection1/'
[junit4:junit4]   2> 2983 T571 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-jetty1-1349517899097/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 2984 T571 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-jetty1-1349517899097/collection1/lib/README' to classloader
[junit4:junit4]   2> 3035 T571 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 3105 T571 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 3123 T592 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3149 T591 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3206 T605 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3206 T571 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 3215 T571 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 3828 T571 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 3840 T571 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 3845 T571 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 3863 T571 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 3870 T571 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 3875 T571 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 3877 T571 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 3879 T571 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1349517899097/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1349517896435/jetty1/
[junit4:junit4]   2> 3880 T571 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6538b0f9
[junit4:junit4]   2> 3881 T571 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1349517896435/jetty1/index/
[junit4:junit4]   2> 3882 T571 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1349517896435/jetty1/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 3883 T571 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-1349517896435/jetty1/index forceNew:false
[junit4:junit4]   2> 3889 T571 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1349517896435/jetty1/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 3890 T571 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 3891 T571 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 3894 T571 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 3894 T571 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 3895 T571 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 3896 T571 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 3897 T571 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 3897 T571 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 3898 T571 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 3899 T571 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 3900 T571 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 3901 T571 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 3902 T571 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 3903 T571 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 3904 T571 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 3904 T571 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 3905 T571 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 3906 T571 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 3907 T571 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3908 T571 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3909 T571 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3910 T571 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3911 T571 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3911 T571 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3912 T571 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3925 T571 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 3927 T571 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 3940 T571 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 3944 T571 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 3946 T571 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> 3951 T571 oass.SolrIndexSearcher.<init> Opening Searcher@529c42c6 main
[junit4:junit4]   2> 3952 T571 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 3953 T571 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 3954 T571 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 3968 T571 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 4031 T606 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@529c42c6 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 4163 T592 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 4189 T605 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4189 T591 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4541 T571 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 4542 T571 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:35338/solr shardId:shard1
[junit4:junit4]   2> 4543 T571 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election
[junit4:junit4]   2> 4550 T576 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a3588eaf90003 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> 4551 T571 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 4552 T576 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a3588eaf90003 type:create cxid:0x44 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4554 T571 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4]   2> 4554 T571 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 4555 T571 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:35338/solr/collection1/
[junit4:junit4]   2> 4556 T571 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4:junit4]   2> 4556 T571 oasc.SyncStrategy.syncToMe http://127.0.0.1:35338/solr/collection1/ has no replicas
[junit4:junit4]   2> 4557 T571 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:35338/solr/collection1/
[junit4:junit4]   2> 4557 T571 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4:junit4]   2> 4562 T576 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a3588eaf90003 type:create cxid:0x4e zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4703 T592 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 4727 T605 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4727 T591 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4768 T571 oasc.ZkController.register We are http://127.0.0.1:35338/solr/collection1/ and leader is http://127.0.0.1:35338/solr/collection1/
[junit4:junit4]   2> 4768 T571 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:35338/solr
[junit4:junit4]   2> 4769 T571 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4]   2> 4771 T571 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 4772 T571 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1
[junit4:junit4]   2> 4773 T571 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 4773 T571 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 4943 T571 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 4946 T571 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:35349
[junit4:junit4]   2> 4947 T571 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 4947 T571 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1349517901218
[junit4:junit4]   2> 4948 T571 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1349517901218/'
[junit4:junit4]   2> 4989 T571 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 4990 T571 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 4990 T571 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1349517901218
[junit4:junit4]   2> 4991 T571 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1349517901218/solr.xml
[junit4:junit4]   2> 4991 T571 oasc.CoreContainer.<init> New CoreContainer 1457201603
[junit4:junit4]   2> 4992 T571 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1349517901218/'
[junit4:junit4]   2> 4993 T571 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1349517901218/'
[junit4:junit4]   2> 5025 T571 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 5040 T571 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:35318/solr
[junit4:junit4]   2> 5041 T571 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:35318/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@6b303637
[junit4:junit4]   2> 5042 T616 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:35318
[junit4:junit4]   2> 5042 T571 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 5044 T616 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost/127.0.0.1:35318, initiating session
[junit4:junit4]   2> 5044 T573 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /140.211.11.196:35350
[junit4:junit4]   2> 5045 T573 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /140.211.11.196:35350
[junit4:junit4]   2> 5047 T575 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a3588eaf90004 with negotiated timeout 5000 for client /140.211.11.196:35350
[junit4:junit4]   2> 5047 T616 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost/127.0.0.1:35318, sessionid = 0x13a3588eaf90004, negotiated timeout = 5000
[junit4:junit4]   2> 5048 T617 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6b303637 name:ZooKeeperConnection Watcher:127.0.0.1:35318/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 5048 T571 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 5049 T576 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a3588eaf90004 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5056 T576 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a3588eaf90004 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5058 T571 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:35349_solr
[junit4:junit4]   2> 5058 T576 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a3588eaf90004 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:35349_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:35349_solr
[junit4:junit4]   2> 5060 T571 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:35349_solr
[junit4:junit4]   2> 5062 T605 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 5062 T591 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 5063 T571 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 5064 T571 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 5064 T571 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 5065 T571 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 5065 T571 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 5066 T571 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 5067 T571 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 5067 T571 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 5068 T571 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 5068 T571 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 5086 T571 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 5093 T571 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1349517901218/collection1
[junit4:junit4]   2> 5094 T571 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 5095 T571 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 5095 T571 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 5097 T571 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1349517901218/collection1/'
[junit4:junit4]   2> 5098 T571 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-jetty2-1349517901218/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 5099 T571 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-jetty2-1349517901218/collection1/lib/README' to classloader
[junit4:junit4]   2> 5151 T571 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 5221 T571 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 5246 T592 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 5251 T605 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5252 T591 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5322 T617 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5322 T571 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 5329 T571 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 5925 T571 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 5933 T571 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 5936 T571 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 5947 T571 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 5951 T571 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 5954 T571 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 5956 T571 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 5957 T571 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1349517901218/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1349517896435/jetty2/
[junit4:junit4]   2> 5958 T571 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6538b0f9
[junit4:junit4]   2> 5959 T571 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1349517896435/jetty2/index/
[junit4:junit4]   2> 5959 T571 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1349517896435/jetty2/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 5960 T571 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-1349517896435/jetty2/index forceNew:false
[junit4:junit4]   2> 5968 T571 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1349517896435/jetty2/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 5968 T571 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 5969 T571 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 5971 T571 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 5972 T571 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 5972 T571 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 5972 T571 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 5973 T571 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 5974 T571 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 5974 T571 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 5975 T571 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 5975 T571 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 5976 T571 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 5977 T571 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 5977 T571 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 5978 T571 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 5978 T571 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 5979 T571 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 5980 T571 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 5980 T571 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5981 T571 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5981 T571 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5982 T571 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5983 T571 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5983 T571 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5984 T571 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5984 T571 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 5985 T571 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 5994 T571 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 5997 T571 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 5998 T571 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> 6002 T571 oass.SolrIndexSearcher.<init> Opening Searcher@5da02c8e main
[junit4:junit4]   2> 6003 T571 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 6003 T571 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 6004 T571 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 6023 T571 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 6087 T618 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5da02c8e main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 6266 T592 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 6270 T605 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 6270 T591 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 6270 T617 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 6597 T571 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 6597 T571 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:35349/solr shardId:shard1
[junit4:junit4]   2> 6604 T571 oasc.ZkController.register We are http://127.0.0.1:35349/solr/collection1/ and leader is http://127.0.0.1:35338/solr/collection1/
[junit4:junit4]   2> 6604 T571 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:35349/solr
[junit4:junit4]   2> 6604 T571 oasc.ZkController.checkRecovery Core needs to recover:collection1
[junit4:junit4]   2> 6605 T571 oasu.DefaultSolrCoreState.doRecovery Running recovery - first canceling any ongoing recovery
[junit4:junit4]   2> ASYNC  NEW_CORE C69 name=collection1 org.apache.solr.core.SolrCore@5f98e01b url=http://127.0.0.1:35349/solr/collection1 node=127.0.0.1:35349_solr
[junit4:junit4]   2> 6606 T619 C69 P35349 oasc.RecoveryStrategy.run Starting recovery process.  core=collection1 recoveringAfterStartup=true
[junit4:junit4]   2> 6606 T571 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 6706 T619 C69 P35349 oasc.RecoveryStrategy.doRecovery ###### startupVersions=[]
[junit4:junit4]   2> 6707 T571 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1
[junit4:junit4]   2> 6707 T619 C69 P35349 oasc.RecoveryStrategy.doRecovery Attempting to PeerSync from http://127.0.0.1:35338/solr/collection1/ core=collection1 - recoveringAfterStartup=true
[junit4:junit4]   2> 6707 T571 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 6708 T619 C69 P35349 oasu.PeerSync.sync PeerSync: core=collection1 url=http://127.0.0.1:35349/solr START replicas=[http://127.0.0.1:35338/solr/collection1/] nUpdates=100
[junit4:junit4]   2> 6708 T571 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 6708 T619 C69 P35349 oasu.PeerSync.sync WARNING no frame of reference to tell of we've missed updates
[junit4:junit4]   2> 6709 T619 C69 P35349 oasc.RecoveryStrategy.doRecovery PeerSync Recovery was not successful - trying replication. core=collection1
[junit4:junit4]   2> 6709 T619 C69 P35349 oasc.RecoveryStrategy.doRecovery Starting Replication Recovery. core=collection1
[junit4:junit4]   2> 6710 T619 C69 P35349 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> ASYNC  NEW_CORE C70 name=collection1 org.apache.solr.core.SolrCore@15cf9d47 url=http://127.0.0.1:35338/solr/collection1 node=127.0.0.1:35338_solr
[junit4:junit4]   2> 6718 T597 C70 P35338 REQ /get {distrib=false&qt=/get&wt=javabin&version=2&getVersions=100} status=0 QTime=0 
[junit4:junit4]   2> 6726 T571 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:35318/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@65abcd6f
[junit4:junit4]   2> 6727 T621 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:35318
[junit4:junit4]   2> 6727 T571 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 6728 T621 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost/127.0.0.1:35318, initiating session
[junit4:junit4]   2> 6728 T573 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /140.211.11.196:35360
[junit4:junit4]   2> 6729 T573 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /140.211.11.196:35360
[junit4:junit4]   2> 6730 T575 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a3588eaf90005 with negotiated timeout 10000 for client /140.211.11.196:35360
[junit4:junit4]   2> 6730 T621 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost/127.0.0.1:35318, sessionid = 0x13a3588eaf90005, negotiated timeout = 10000
[junit4:junit4]   2> 6731 T622 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@65abcd6f name:ZooKeeperConnection Watcher:127.0.0.1:35318/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 6731 T571 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 6732 T571 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 6734 T571 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:true cause connection loss:true
[junit4:junit4]   2> 6734 T571 oascsi.HttpClientUtil.createClient Creating new http client, config:
[junit4:junit4]   2> 6745 T571 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> ASYNC  NEW_CORE C71 name=collection1 org.apache.solr.core.SolrCore@10e4316d url=http://127.0.0.1:35321/solr/collection1 node=127.0.0.1:35321_solr
[junit4:junit4]   2> 6757 T583 C71 P35321 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1349517896435/control/data/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 6757 T583 C71 P35321 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 6762 T584 C71 P35321 /update {wt=javabin&version=2} {add=[1 (1415072084850114560)]} 0 7
[junit4:junit4]   2> 6762 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10001 (1415072084848017408)]} 0 9
[junit4:junit4]   2> 6763 T623 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:35318/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@2bf99714
[junit4:junit4]   2> 6763 T625 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:35318
[junit4:junit4]   2> 6763 T623 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 6764 T625 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost/127.0.0.1:35318, initiating session
[junit4:junit4]   2> 6764 T573 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /140.211.11.196:35364
[junit4:junit4]   2> 6765 T573 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /140.211.11.196:35364
[junit4:junit4]   2> 6767 T575 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a3588eaf90006 with negotiated timeout 10000 for client /140.211.11.196:35364
[junit4:junit4]   2> 6767 T625 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost/127.0.0.1:35318, sessionid = 0x13a3588eaf90006, negotiated timeout = 10000
[junit4:junit4]   2> 6767 T626 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@2bf99714 name:ZooKeeperConnection Watcher:127.0.0.1:35318/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 6767 T623 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 6768 T623 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 6774 T592 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 6775 T599 C70 P35338 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1349517896435/jetty1/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 6776 T599 C70 P35338 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 6779 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10001 (1415072084867940353)]} 0 7
[junit4:junit4]   2> 6780 T599 C70 P35338 /update {wt=javabin&version=2} {add=[1 (1415072084867940352)]} 0 9
[junit4:junit4]   2> 6784 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[1 (-1415072084879474688)]} 0 1
[junit4:junit4]   2> 6784 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[10001 (-1415072084879474689)]} 0 1
[junit4:junit4]   2> 6787 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[1 (-1415072084882620416)]} 0 1
[junit4:junit4]   2> 6788 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[10001 (-1415072084883668992)]} 0 0
[junit4:junit4]   2> 6788 T617 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 6788 T591 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 6788 T626 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 6788 T622 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 6788 T605 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 6793 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10002 (1415072084887863297)]} 0 2
[junit4:junit4]   2> 6793 T583 C71 P35321 /update {wt=javabin&version=2} {add=[2 (1415072084887863296)]} 0 2
[junit4:junit4]   2>  C69_STATE=coll:collection1 core:collection1 props:{shard=shard1, roles=null, state=recovering, core=collection1, collection=collection1, node_name=127.0.0.1:35349_solr, base_url=http://127.0.0.1:35349/solr}
[junit4:junit4]   2> 6806 T609 C69 P35349 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1349517896435/jetty2/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 6807 T609 C69 P35349 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 6811 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=8 
[junit4:junit4]   2> 6811 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=6 
[junit4:junit4]   2> 6812 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10002 (1415072084893106177)]} 0 16
[junit4:junit4]   2> 6812 T599 C70 P35338 /update {wt=javabin&version=2} {add=[2 (1415072084893106176)]} 0 16
[junit4:junit4]   2> 6816 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10003 (1415072084914077696)]} 0 1
[junit4:junit4]   2> 6817 T583 C71 P35321 /update {wt=javabin&version=2} {add=[3 (1415072084913029120)]} 0 2
[junit4:junit4]   2> 6823 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6824 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10003 (1415072084917223424)]} 0 5
[junit4:junit4]   2> 6824 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6825 T600 C70 P35338 /update {wt=javabin&version=2} {add=[3 (1415072084918272000)]} 0 5
[junit4:junit4]   2> 6829 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10004 (1415072084925612032)]} 0 2
[junit4:junit4]   2> 6829 T584 C71 P35321 /update {wt=javabin&version=2} {add=[4 (1415072084926660608)]} 0 1
[junit4:junit4]   2> 6836 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6837 T600 C70 P35338 /update {wt=javabin&version=2} {add=[4 (1415072084930854912)]} 0 5
[junit4:junit4]   2> 6837 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6838 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10004 (1415072084930854913)]} 0 6
[junit4:junit4]   2> 6839 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[2 (-1415072084938194944)]} 0 0
[junit4:junit4]   2> 6841 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[10002 (-1415072084940292096)]} 0 1
[junit4:junit4]   2> 6845 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6846 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[2 (-1415072084942389248)]} 0 4
[junit4:junit4]   2> 6846 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6847 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[10002 (-1415072084943437824)]} 0 3
[junit4:junit4]   2> 6851 T583 C71 P35321 /update {wt=javabin&version=2} {add=[5 (1415072084948680704)]} 0 2
[junit4:junit4]   2> 6851 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10005 (1415072084949729280)]} 0 1
[junit4:junit4]   2> 6858 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6859 T600 C70 P35338 /update {wt=javabin&version=2} {add=[5 (1415072084953923585)]} 0 5
[junit4:junit4]   2> 6863 T584 C71 P35321 /update {wt=javabin&version=2} {add=[6 (1415072084962312192)]} 0 2
[junit4:junit4]   2> 6866 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6867 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10005 (1415072084953923584)]} 0 13
[junit4:junit4]   2> 6882 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10006 (1415072084983283712)]} 0 1
[junit4:junit4]   2> 6883 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6884 T600 C70 P35338 /update {wt=javabin&version=2} {add=[6 (1415072084966506496)]} 0 18
[junit4:junit4]   2> 6887 T584 C71 P35321 /update {wt=javabin&version=2} {add=[7 (1415072084987478016)]} 0 1
[junit4:junit4]   2> 6889 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6889 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10006 (1415072084986429440)]} 0 4
[junit4:junit4]   2> 6893 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10007 (1415072084993769472)]} 0 1
[junit4:junit4]   2> 6894 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6895 T600 C70 P35338 /update {wt=javabin&version=2} {add=[7 (1415072084991672320)]} 0 5
[junit4:junit4]   2> 6901 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 6902 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10007 (1415072084997963776)]} 0 6
[junit4:junit4]   2> 6907 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10008 (1415072085007400960)]} 0 2
[junit4:junit4]   2> 6909 T584 C71 P35321 /update {wt=javabin&version=2} {add=[8 (1415072085000060928)]} 0 11
[junit4:junit4]   2> 6918 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 6918 T600 C70 P35338 /update {wt=javabin&version=2} {add=[8 (1415072085014740992)]} 0 6
[junit4:junit4]   2> 6923 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[4 (-1415072085025226752)]} 0 1
[junit4:junit4]   2> 6925 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=11 
[junit4:junit4]   2> 6926 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10008 (1415072085012643840)]} 0 16
[junit4:junit4]   2> 6929 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6930 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[10004 (-1415072085032566784)]} 0 1
[junit4:junit4]   2> 6930 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[4 (-1415072085029421056)]} 0 5
[junit4:junit4]   2> 6936 T584 C71 P35321 /update {wt=javabin&version=2} {add=[9 (1415072085036761088)]} 0 3
[junit4:junit4]   2> 6937 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6937 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[10004 (-1415072085036761088)]} 0 4
[junit4:junit4]   2> 6942 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10009 (1415072085045149696)]} 0 2
[junit4:junit4]   2> 6945 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 6945 T599 C70 P35338 /update {wt=javabin&version=2} {add=[9 (1415072085043052544)]} 0 6
[junit4:junit4]   2> 6950 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10 (1415072085052489728)]} 0 2
[junit4:junit4]   2> 6951 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 6951 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10009 (1415072085049344000)]} 0 6
[junit4:junit4]   2> 6956 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10010 (1415072085058781184)]} 0 2
[junit4:junit4]   2> 6959 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 6960 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10 (1415072085057732608)]} 0 8
[junit4:junit4]   2> 6964 T584 C71 P35321 /update {wt=javabin&version=2} {add=[11 (1415072085068218368)]} 0 1
[junit4:junit4]   2> 6974 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 6974 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10010 (1415072085064024064)]} 0 15
[junit4:junit4]   2> 6976 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 6977 T599 C70 P35338 /update {wt=javabin&version=2} {add=[11 (1415072085072412672)]} 0 10
[junit4:junit4]   2> 6979 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10011 (1415072085083947008)]} 0 2
[junit4:junit4]   2> 6981 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[5 (-1415072085086044160)]} 0 1
[junit4:junit4]   2> 6987 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6988 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[5 (-1415072085089189888)]} 0 5
[junit4:junit4]   2> 6988 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 6989 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10011 (1415072085088141312)]} 0 7
[junit4:junit4]   2> 6992 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[10005 (-1415072085098627072)]} 0 0
[junit4:junit4]   2> 6993 T583 C71 P35321 /update {wt=javabin&version=2} {add=[12 (1415072085097578496)]} 0 2
[junit4:junit4]   2> 6999 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6999 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[10005 (-1415072085101772800)]} 0 4
[junit4:junit4]   2> 7001 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7002 T600 C70 P35338 /update {wt=javabin&version=2} {add=[12 (1415072085102821376)]} 0 6
[junit4:junit4]   2> 7004 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10012 (1415072085109112832)]} 0 1
[junit4:junit4]   2> 7007 T584 C71 P35321 /update {wt=javabin&version=2} {add=[13 (1415072085112258560)]} 0 2
[junit4:junit4]   2> 7015 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7015 T599 C70 P35338 /update {wt=javabin&version=2} {add=[13 (1415072085116452864)]} 0 6
[junit4:junit4]   2> 7020 T584 C71 P35321 /update {wt=javabin&version=2} {add=[14 (1415072085125890048)]} 0 2
[junit4:junit4]   2> 7021 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=11 
[junit4:junit4]   2> 7022 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10012 (1415072085113307136)]} 0 16
[junit4:junit4]   2> 7027 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10013 (1415072085133230080)]} 0 2
[junit4:junit4]   2> 7030 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 7031 T599 C70 P35338 /update {wt=javabin&version=2} {add=[14 (1415072085132181504)]} 0 8
[junit4:junit4]   2> 7036 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7037 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10013 (1415072085139521536)]} 0 7
[junit4:junit4]   2> 7042 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10014 (1415072085150007296)]} 0 2
[junit4:junit4]   2> 7045 T584 C71 P35321 /update {wt=javabin&version=2} {add=[15 (1415072085142667264)]} 0 11
[junit4:junit4]   2> 7051 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7051 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10014 (1415072085154201600)]} 0 6
[junit4:junit4]   2> 7054 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7054 T599 C70 P35338 /update {wt=javabin&version=2} {add=[15 (1415072085158395904)]} 0 6
[junit4:junit4]   2> 7057 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10015 (1415072085163638784)]} 0 3
[junit4:junit4]   2> 7059 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[7 (-1415072085167833088)]} 0 1
[junit4:junit4]   2> 7065 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7066 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[7 (-1415072085172027392)]} 0 4
[junit4:junit4]   2> 7074 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7075 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10015 (1415072085169930240)]} 0 15
[junit4:junit4]   2> 7079 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[10007 (-1415072085188804608)]} 0 1
[junit4:junit4]   2> 7081 T583 C71 P35321 /update {wt=javabin&version=2} {add=[16 (1415072085179367424)]} 0 12
[junit4:junit4]   2> 7085 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7087 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[10007 (-1415072085192998912)]} 0 6
[junit4:junit4]   2> 7090 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7091 T600 C70 P35338 /update {wt=javabin&version=2} {add=[16 (1415072085195096064)]} 0 7
[junit4:junit4]   2> 7093 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10016 (1415072085201387520)]} 0 3
[junit4:junit4]   2> 7095 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[11 (-1415072085205581824)]} 0 0
[junit4:junit4]   2> 7101 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7101 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[11 (-1415072085208727552)]} 0 4
[junit4:junit4]   2> 7102 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7103 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10016 (1415072085207678976)]} 0 7
[junit4:junit4]   2> 7106 T584 C71 P35321 /update {wt=javabin&version=2} {add=[17 (1415072085216067584)]} 0 2
[junit4:junit4]   2> 7107 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[10011 (-1415072085219213312)]} 0 1
[junit4:junit4]   2> 7114 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7115 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[10011 (-1415072085222359040)]} 0 5
[junit4:junit4]   2> 7116 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 7116 T600 C70 P35338 /update {wt=javabin&version=2} {add=[17 (1415072085221310464)]} 0 7
[junit4:junit4]   2> 7119 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10017 (1415072085230747648)]} 0 1
[junit4:junit4]   2> 7119 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[13 (-1415072085231796224)]} 0 0
[junit4:junit4]   2> 7126 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7126 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[13 (-1415072085234941952)]} 0 4
[junit4:junit4]   2> 7128 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7129 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10017 (1415072085235990528)]} 0 6
[junit4:junit4]   2> 7130 T583 C71 P35321 /update {wt=javabin&version=2} {add=[18 (1415072085242281984)]} 0 1
[junit4:junit4]   2> 7133 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[10013 (-1415072085245427712)]} 0 1
[junit4:junit4]   2> 7139 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7139 T599 C70 P35338 /update {wt=javabin&version=2} {add=[18 (1415072085247524864)]} 0 6
[junit4:junit4]   2> 7140 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7141 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[10013 (-1415072085249622016)]} 0 5
[junit4:junit4]   2> 7144 T584 C71 P35321 /update {wt=javabin&version=2} {add=[19 (1415072085255913472)]} 0 2
[junit4:junit4]   2> 7146 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10018 (1415072085258010624)]} 0 2
[junit4:junit4]   2> 7153 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7153 T600 C70 P35338 /update {wt=javabin&version=2} {add=[19 (1415072085262204928)]} 0 6
[junit4:junit4]   2> 7154 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7154 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10018 (1415072085263253504)]} 0 6
[junit4:junit4]   2> 7157 T583 C71 P35321 /update {wt=javabin&version=2} {add=[20 (1415072085270593536)]} 0 1
[junit4:junit4]   2> 7158 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10019 (1415072085271642112)]} 0 1
[junit4:junit4]   2> 7165 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7166 T599 C70 P35338 /update {wt=javabin&version=2} {add=[20 (1415072085274787840)]} 0 6
[junit4:junit4]   2> 7166 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7167 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10019 (1415072085275836416)]} 0 6
[junit4:junit4]   2> 7171 T584 C71 P35321 /update {wt=javabin&version=2} {add=[21 (1415072085285273600)]} 0 2
[junit4:junit4]   2> 7172 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10020 (1415072085285273601)]} 0 2
[junit4:junit4]   2> 7189 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7190 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10020 (1415072085289467904)]} 0 16
[junit4:junit4]   2> 7192 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=11 
[junit4:junit4]   2> 7193 T600 C70 P35338 /update {wt=javabin&version=2} {add=[21 (1415072085289467905)]} 0 19
[junit4:junit4]   2> 7195 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10021 (1415072085310439424)]} 0 2
[junit4:junit4]   2> 7197 T584 C71 P35321 /update {wt=javabin&version=2} {add=[22 (1415072085312536576)]} 0 1
[junit4:junit4]   2> 7205 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 7206 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10021 (1415072085314633728)]} 0 8
[junit4:junit4]   2> 7210 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10022 (1415072085326168064)]} 0 1
[junit4:junit4]   2> 7215 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=11 
[junit4:junit4]   2> 7215 T599 C70 P35338 /update {wt=javabin&version=2} {add=[22 (1415072085316730880)]} 0 15
[junit4:junit4]   2> 7218 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7219 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[14 (-1415072085335605248)]} 0 1
[junit4:junit4]   2> 7219 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10022 (1415072085330362368)]} 0 6
[junit4:junit4]   2> 7223 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[10014 (-1415072085339799552)]} 0 1
[junit4:junit4]   2> 7226 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7227 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[14 (-1415072085339799552)]} 0 5
[junit4:junit4]   2> 7229 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7230 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[10014 (-1415072085345042432)]} 0 4
[junit4:junit4]   2> 7232 T584 C71 P35321 /update {wt=javabin&version=2} {add=[23 (1415072085348188160)]} 0 2
[junit4:junit4]   2> 7234 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10023 (1415072085351333888)]} 0 1
[junit4:junit4]   2> 7239 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7240 T600 C70 P35338 /update {wt=javabin&version=2} {add=[23 (1415072085353431040)]} 0 5
[junit4:junit4]   2> 7244 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 7244 T583 C71 P35321 /update {wt=javabin&version=2} {add=[24 (1415072085361819648)]} 0 1
[junit4:junit4]   2> 7245 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10023 (1415072085355528192)]} 0 8
[junit4:junit4]   2> 7252 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7253 T600 C70 P35338 /update {wt=javabin&version=2} {add=[24 (1415072085366013952)]} 0 6
[junit4:junit4]   2> 7256 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[16 (-1415072085375451136)]} 0 0
[junit4:junit4]   2> 7259 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10024 (1415072085368111104)]} 0 11
[junit4:junit4]   2> 7263 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7264 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[16 (-1415072085379645440)]} 0 5
[junit4:junit4]   2> 7267 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7268 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10024 (1415072085382791168)]} 0 6
[junit4:junit4]   2> 7270 T583 C71 P35321 /update {wt=javabin&version=2} {add=[25 (1415072085386985472)]} 0 3
[junit4:junit4]   2> 7271 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[10016 (-1415072085391179776)]} 0 0
[junit4:junit4]   2> 7278 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7279 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7279 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[10016 (-1415072085395374080)]} 0 5
[junit4:junit4]   2> 7279 T599 C70 P35338 /update {wt=javabin&version=2} {add=[25 (1415072085393276928)]} 0 6
[junit4:junit4]   2> 7283 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10025 (1415072085402714113)]} 0 1
[junit4:junit4]   2> 7283 T583 C71 P35321 /update {wt=javabin&version=2} {add=[26 (1415072085402714112)]} 0 1
[junit4:junit4]   2> 7296 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7297 T600 C70 P35338 /update {wt=javabin&version=2} {add=[26 (1415072085407956993)]} 0 10
[junit4:junit4]   2> 7300 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[24 (-1415072085421588480)]} 0 0
[junit4:junit4]   2> 7302 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7303 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10025 (1415072085407956992)]} 0 16
[junit4:junit4]   2> 7307 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7307 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[24 (-1415072085424734208)]} 0 4
[junit4:junit4]   2> 7308 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10026 (1415072085428928512)]} 0 2
[junit4:junit4]   2> 7317 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7317 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10026 (1415072085434171392)]} 0 6
[junit4:junit4]   2> 7321 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[10024 (-1415072085442560000)]} 0 1
[junit4:junit4]   2> 7321 T584 C71 P35321 /update {wt=javabin&version=2} {add=[27 (1415072085432074240)]} 0 11
[junit4:junit4]   2> 7328 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7328 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[10024 (-1415072085447802880)]} 0 4
[junit4:junit4]   2> 7330 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7331 T599 C70 P35338 /update {wt=javabin&version=2} {add=[27 (1415072085447802881)]} 0 7
[junit4:junit4]   2> 7335 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10027 (1415072085456191488)]} 0 3
[junit4:junit4]   2> 7335 T583 C71 P35321 /update {wt=javabin&version=2} {add=[28 (1415072085457240064)]} 0 1
[junit4:junit4]   2> 7343 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7343 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7344 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10027 (1415072085462482944)]} 0 6
[junit4:junit4]   2> 7344 T600 C70 P35338 /update {wt=javabin&version=2} {add=[28 (1415072085461434368)]} 0 6
[junit4:junit4]   2> 7348 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[25 (-1415072085471920128)]} 0 1
[junit4:junit4]   2> 7349 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10028 (1415072085471920129)]} 0 2
[junit4:junit4]   2> 7355 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7355 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[25 (-1415072085475065856)]} 0 4
[junit4:junit4]   2> 7356 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7357 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10028 (1415072085475065857)]} 0 6
[junit4:junit4]   2> 7360 T583 C71 P35321 /update {wt=javabin&version=2} {add=[29 (1415072085483454464)]} 0 2
[junit4:junit4]   2> 7360 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[10025 (-1415072085484503040)]} 0 0
[junit4:junit4]   2> 7366 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7367 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[10025 (-1415072085488697344)]} 0 4
[junit4:junit4]   2> 7368 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7369 T599 C70 P35338 /update {wt=javabin&version=2} {add=[29 (1415072085488697345)]} 0 6
[junit4:junit4]   2> 7371 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10029 (1415072085494988800)]} 0 1
[junit4:junit4]   2> 7373 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[27 (-1415072085497085952)]} 0 1
[junit4:junit4]   2> 7380 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7380 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[27 (-1415072085501280256)]} 0 4
[junit4:junit4]   2> 7384 T583 C71 P35321 /update {wt=javabin&version=2} {add=[30 (1415072085508620288)]} 0 1
[junit4:junit4]   2> 7391 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=11 
[junit4:junit4]   2> 7391 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7392 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10029 (1415072085502328832)]} 0 16
[junit4:junit4]   2> 7392 T600 C70 P35338 /update {wt=javabin&version=2} {add=[30 (1415072085512814592)]} 0 5
[junit4:junit4]   2> 7396 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[10027 (-1415072085522251776)]} 0 1
[junit4:junit4]   2> 7397 T584 C71 P35321 /update {wt=javabin&version=2} {add=[31 (1415072085522251777)]} 0 2
[junit4:junit4]   2> 7403 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7403 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[10027 (-1415072085526446080)]} 0 4
[junit4:junit4]   2> 7408 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10030 (1415072085533786112)]} 0 2
[junit4:junit4]   2> 7415 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7416 T599 C70 P35338 /update {wt=javabin&version=2} {add=[31 (1415072085526446081)]} 0 16
[junit4:junit4]   2> 7419 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 7420 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10030 (1415072085537980416)]} 0 9
[junit4:junit4]   2> 7420 T584 C71 P35321 /update {wt=javabin&version=2} {add=[32 (1415072085546369024)]} 0 1
[junit4:junit4]   2> 7425 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10031 (1415072085550563328)]} 0 2
[junit4:junit4]   2> 7429 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7430 T600 C70 P35338 /update {wt=javabin&version=2} {add=[32 (1415072085550563328)]} 0 7
[junit4:junit4]   2> 7433 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7434 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10031 (1415072085556854784)]} 0 6
[junit4:junit4]   2> 7434 T583 C71 P35321 /update {wt=javabin&version=2} {add=[33 (1415072085561049088)]} 0 1
[junit4:junit4]   2> 7438 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10032 (1415072085565243392)]} 0 1
[junit4:junit4]   2> 7442 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7443 T599 C70 P35338 /update {wt=javabin&version=2} {add=[33 (1415072085565243392)]} 0 6
[junit4:junit4]   2> 7446 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7447 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10032 (1415072085570486272)]} 0 6
[junit4:junit4]   2> 7447 T584 C71 P35321 /update {wt=javabin&version=2} {add=[34 (1415072085574680576)]} 0 1
[junit4:junit4]   2> 7461 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10033 (1415072085578874880)]} 0 11
[junit4:junit4]   2> 7465 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=11 
[junit4:junit4]   2> 7465 T600 C70 P35338 /update {wt=javabin&version=2} {add=[34 (1415072085578874880)]} 0 15
[junit4:junit4]   2> 7468 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[33 (-1415072085597749248)]} 0 0
[junit4:junit4]   2> 7471 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 7472 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10033 (1415072085593554944)]} 0 8
[junit4:junit4]   2> 7475 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7475 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[33 (-1415072085601943552)]} 0 4
[junit4:junit4]   2> 7478 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10034 (1415072085605089280)]} 0 3
[junit4:junit4]   2> 7479 T584 C71 P35321 /update {wt=javabin&version=2} {add=[35 (1415072085608235008)]} 0 1
[junit4:junit4]   2> 7486 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7487 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10034 (1415072085611380736)]} 0 6
[junit4:junit4]   2> 7487 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7488 T599 C70 P35338 /update {wt=javabin&version=2} {add=[35 (1415072085612429312)]} 0 6
[junit4:junit4]   2> 7491 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[10033 (-1415072085620817920)]} 0 1
[junit4:junit4]   2> 7492 T583 C71 P35321 /update {wt=javabin&version=2} {add=[36 (1415072085621866496)]} 0 1
[junit4:junit4]   2> 7499 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7500 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[10033 (-1415072085627109376)]} 0 5
[junit4:junit4]   2> 7505 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10035 (1415072085635497984)]} 0 2
[junit4:junit4]   2> 7510 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7511 T599 C70 P35338 /update {wt=javabin&version=2} {add=[36 (1415072085627109377)]} 0 16
[junit4:junit4]   2> 7514 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7515 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[34 (-1415072085645983744)]} 0 1
[junit4:junit4]   2> 7515 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10035 (1415072085639692288)]} 0 7
[junit4:junit4]   2> 7520 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7521 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[34 (-1415072085649129472)]} 0 4
[junit4:junit4]   2> 7526 T583 C71 P35321 /update {wt=javabin&version=2} {add=[37 (1415072085656469504)]} 0 2
[junit4:junit4]   2> 7529 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10036 (1415072085650178048)]} 0 11
[junit4:junit4]   2> 7535 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7536 T599 C70 P35338 /update {wt=javabin&version=2} {add=[37 (1415072085662760960)]} 0 7
[junit4:junit4]   2> 7538 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7539 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10036 (1415072085665906688)]} 0 7
[junit4:junit4]   2> 7540 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[36 (-1415072085673246720)]} 0 1
[junit4:junit4]   2> 7542 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[10034 (-1415072085675343872)]} 0 0
[junit4:junit4]   2> 7547 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7548 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[36 (-1415072085677441024)]} 0 5
[junit4:junit4]   2> 7550 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7551 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[10034 (-1415072085680586752)]} 0 5
[junit4:junit4]   2> 7553 T583 C71 P35321 /update {wt=javabin&version=2} {add=[38 (1415072085685829632)]} 0 1
[junit4:junit4]   2> 7558 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10037 (1415072085687926784)]} 0 4
[junit4:junit4]   2> 7563 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7563 T599 C70 P35338 /update {wt=javabin&version=2} {add=[38 (1415072085691072512)]} 0 6
[junit4:junit4]   2> 7567 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7567 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10037 (1415072085695266816)]} 0 6
[junit4:junit4]   2> 7569 T584 C71 P35321 /update {wt=javabin&version=2} {add=[39 (1415072085701558272)]} 0 2
[junit4:junit4]   2> 7571 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[10036 (-1415072085704704000)]} 0 1
[junit4:junit4]   2> 7576 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7577 T600 C70 P35338 /update {wt=javabin&version=2} {add=[39 (1415072085706801152)]} 0 6
[junit4:junit4]   2> 7579 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7580 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[10036 (-1415072085710995456)]} 0 5
[junit4:junit4]   2> 7582 T583 C71 P35321 /update {wt=javabin&version=2} {add=[40 (1415072085716238336)]} 0 2
[junit4:junit4]   2> 7585 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10038 (1415072085718335488)]} 0 2
[junit4:junit4]   2> 7594 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7595 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10038 (1415072085723578368)]} 0 6
[junit4:junit4]   2> 7600 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10039 (1415072085735112704)]} 0 2
[junit4:junit4]   2> 7602 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=13 
[junit4:junit4]   2> 7603 T599 C70 P35338 /update {wt=javabin&version=2} {add=[40 (1415072085721481216)]} 0 18
[junit4:junit4]   2> 7608 T584 C71 P35321 /update {wt=javabin&version=2} {add=[41 (1415072085742452736)]} 0 2
[junit4:junit4]   2> 7610 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 7611 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10039 (1415072085740355584)]} 0 8
[junit4:junit4]   2> 7616 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10040 (1415072085751889920)]} 0 2
[junit4:junit4]   2> 7627 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7627 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10040 (1415072085756084224)]} 0 8
[junit4:junit4]   2> 7632 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10041 (1415072085768667136)]} 0 2
[junit4:junit4]   2> 7642 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7643 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10041 (1415072085774958592)]} 0 7
[junit4:junit4]   2> 7647 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[10041 (-1415072085785444352)]} 0 1
[junit4:junit4]   2> 7654 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7655 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[10041 (-1415072085788590080)]} 0 5
[junit4:junit4]   2> 7660 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10042 (1415072085798027264)]} 0 2
[junit4:junit4]   2> 7670 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7671 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10042 (1415072085804318720)]} 0 7
[junit4:junit4]   2> 7676 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10043 (1415072085814804480)]} 0 2
[junit4:junit4]   2> 7685 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7686 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10043 (1415072085821095936)]} 0 6
[junit4:junit4]   2> 7690 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[10043 (-1415072085830533120)]} 0 1
[junit4:junit4]   2> 7697 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7698 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[10043 (-1415072085833678848)]} 0 5
[junit4:junit4]   2> 7701 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7702 T599 C70 P35338 /update {wt=javabin&version=2} {add=[41 (1415072085747695616)]} 0 91
[junit4:junit4]   2> 7706 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[41 (-1415072085846261760)]} 0 1
[junit4:junit4]   2> 7713 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7714 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[41 (-1415072085850456064)]} 0 5
[junit4:junit4]   2> 7719 T583 C71 P35321 /update {wt=javabin&version=2} {add=[42 (1415072085859893248)]} 0 2
[junit4:junit4]   2> 7728 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7729 T599 C70 P35338 /update {wt=javabin&version=2} {add=[42 (1415072085864087552)]} 0 7
[junit4:junit4]   2> 7734 T583 C71 P35321 /update {wt=javabin&version=2} {add=[43 (1415072085875621888)]} 0 2
[junit4:junit4]   2> 7743 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7744 T599 C70 P35338 /update {wt=javabin&version=2} {add=[43 (1415072085880864768)]} 0 7
[junit4:junit4]   2> 7748 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[43 (-1415072085890301952)]} 0 1
[junit4:junit4]   2> 7755 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7756 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[43 (-1415072085894496256)]} 0 5
[junit4:junit4]   2> 7761 T583 C71 P35321 /update {wt=javabin&version=2} {add=[44 (1415072085902884864)]} 0 2
[junit4:junit4]   2> 7813 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10044 (1415072085842067456)]} 0 112
[junit4:junit4]   2> 7822 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7823 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10044 (1415072085964750848)]} 0 6
[junit4:junit4]   2> 7830 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10045 (1415072085973139456)]} 0 3
[junit4:junit4]   2> 7838 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7839 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10045 (1415072085981528064)]} 0 6
[junit4:junit4]   2> 7845 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10046 (1415072085992013824)]} 0 1
[junit4:junit4]   2> 7869 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 7870 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10046 (1415072085997256704)]} 0 21
[junit4:junit4]   2> 7874 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[10045 (-1415072086023471104)]} 0 1
[junit4:junit4]   2> 7876 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=108 
[junit4:junit4]   2> 7877 T599 C70 P35338 /update {wt=javabin&version=2} {add=[44 (1415072085909176320)]} 0 113
[junit4:junit4]   2> 7881 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7881 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[10045 (-1415072086026616832)]} 0 4
[junit4:junit4]   2> 7882 T584 C71 P35321 /update {wt=javabin&version=2} {add=[45 (1415072086029762560)]} 0 2
[junit4:junit4]   2> 7886 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10047 (1415072086035005440)]} 0 2
[junit4:junit4]   2> 7893 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 7894 T600 C70 P35338 /update {wt=javabin&version=2} {add=[45 (1415072086035005440)]} 0 9
[junit4:junit4]   2> 7894 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7895 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10047 (1415072086039199744)]} 0 6
[junit4:junit4]   2> 7900 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10048 (1415072086049685504)]} 0 2
[junit4:junit4]   2> 7927 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=20 
[junit4:junit4]   2> 7928 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10048 (1415072086053879808)]} 0 25
[junit4:junit4]   2> 7933 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10049 (1415072086084288512)]} 0 2
[junit4:junit4]   2> 7944 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 7945 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10049 (1415072086088482816)]} 0 9
[junit4:junit4]   2> 7945 T583 C71 P35321 /update {wt=javabin&version=2} {add=[46 (1415072086048636928)]} 0 48
[junit4:junit4]   2> 7950 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10050 (1415072086102114304)]} 0 2
[junit4:junit4]   2> 7954 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7955 T599 C70 P35338 /update {wt=javabin&version=2} {add=[46 (1415072086102114304)]} 0 6
[junit4:junit4]   2> 7957 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7958 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10050 (1415072086105260032)]} 0 6
[junit4:junit4]   2> 7958 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[45 (-1415072086111551488)]} 0 0
[junit4:junit4]   2> 7965 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7965 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10051 (1415072086114697216)]} 0 4
[junit4:junit4]   2> 7965 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[45 (-1415072086115745792)]} 0 4
[junit4:junit4]   2> 7970 T583 C71 P35321 /update {wt=javabin&version=2} {add=[47 (1415072086123085824)]} 0 2
[junit4:junit4]   2> 7973 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7974 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10051 (1415072086122037248)]} 0 6
[junit4:junit4]   2> 7978 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7979 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10052 (1415072086131474432)]} 0 2
[junit4:junit4]   2> 7979 T600 C70 P35338 /update {wt=javabin&version=2} {add=[47 (1415072086127280128)]} 0 6
[junit4:junit4]   2> 7983 T583 C71 P35321 /update {wt=javabin&version=2} {add=[48 (1415072086136717312)]} 0 1
[junit4:junit4]   2> 7987 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7988 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10052 (1415072086136717312)]} 0 6
[junit4:junit4]   2> 7992 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[10049 (-1415072086146154496)]} 0 1
[junit4:junit4]   2> 7999 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8000 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[10049 (-1415072086150348800)]} 0 5
[junit4:junit4]   2> 8002 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8002 T600 C70 P35338 /update {wt=javabin&version=2} {add=[48 (1415072086140911616)]} 0 16
[junit4:junit4]   2> 8003 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10053 (1415072086157688832)]} 0 1
[junit4:junit4]   2> 8006 T584 C71 P35321 /update {wt=javabin&version=2} {add=[49 (1415072086160834560)]} 0 1
[junit4:junit4]   2> 8013 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8014 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10053 (1415072086161883136)]} 0 8
[junit4:junit4]   2> 8014 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8015 T599 C70 P35338 /update {wt=javabin&version=2} {add=[49 (1415072086165028864)]} 0 6
[junit4:junit4]   2> 8019 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10054 (1415072086173417472)]} 0 2
[junit4:junit4]   2> 8019 T583 C71 P35321 /update {wt=javabin&version=2} {add=[50 (1415072086174466048)]} 0 1
[junit4:junit4]   2> 8028 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8029 T600 C70 P35338 /update {wt=javabin&version=2} {add=[50 (1415072086178660352)]} 0 7
[junit4:junit4]   2> 8029 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8030 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10054 (1415072086178660353)]} 0 8
[junit4:junit4]   2> 8034 T583 C71 P35321 /update {wt=javabin&version=2} {add=[51 (1415072086190194688)]} 0 2
[junit4:junit4]   2> 8034 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10055 (1415072086190194689)]} 0 1
[junit4:junit4]   2> 8043 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8043 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8044 T599 C70 P35338 /update {wt=javabin&version=2} {add=[51 (1415072086194388992)]} 0 7
[junit4:junit4]   2> 8044 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10055 (1415072086195437568)]} 0 7
[junit4:junit4]   2> 8049 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10056 (1415072086205923328)]} 0 1
[junit4:junit4]   2> 8056 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8057 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10056 (1415072086210117632)]} 0 5
[junit4:junit4]   2> 8058 T584 C71 P35321 /update {wt=javabin&version=2} {add=[52 (1415072086204874752)]} 0 11
[junit4:junit4]   2> 8061 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10057 (1415072086218506240)]} 0 1
[junit4:junit4]   2> 8069 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8070 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10057 (1415072086222700544)]} 0 6
[junit4:junit4]   2> 8075 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=11 
[junit4:junit4]   2> 8076 T600 C70 P35338 /update {wt=javabin&version=2} {add=[52 (1415072086219554816)]} 0 15
[junit4:junit4]   2> 8080 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[49 (-1415072086238429184)]} 0 1
[junit4:junit4]   2> 8083 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10058 (1415072086232137728)]} 0 10
[junit4:junit4]   2> 8087 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8087 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[49 (-1415072086242623488)]} 0 4
[junit4:junit4]   2> 8093 T583 C71 P35321 /update {wt=javabin&version=2} {add=[53 (1415072086249963520)]} 0 3
[junit4:junit4]   2> 8102 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 8103 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8103 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10058 (1415072086245769216)]} 0 17
[junit4:junit4]   2> 8103 T600 C70 P35338 /update {wt=javabin&version=2} {add=[53 (1415072086257303552)]} 0 7
[junit4:junit4]   2> 8106 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[10050 (-1415072086266740736)]} 0 0
[junit4:junit4]   2> 8109 T584 C71 P35321 /update {wt=javabin&version=2} {add=[54 (1415072086267789312)]} 0 3
[junit4:junit4]   2> 8112 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8113 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[10050 (-1415072086269886464)]} 0 4
[junit4:junit4]   2> 8117 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8117 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10059 (1415072086278275072)]} 0 1
[junit4:junit4]   2> 8118 T599 C70 P35338 /update {wt=javabin&version=2} {add=[54 (1415072086274080768)]} 0 6
[junit4:junit4]   2> 8122 T584 C71 P35321 /update {wt=javabin&version=2} {add=[55 (1415072086282469376)]} 0 1
[junit4:junit4]   2> 8130 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8131 T599 C70 P35338 /update {wt=javabin&version=2} {add=[55 (1415072086286663680)]} 0 6
[junit4:junit4]   2> 8135 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=11 
[junit4:junit4]   2> 8135 T584 C71 P35321 /update {wt=javabin&version=2} {add=[56 (1415072086296100864)]} 0 1
[junit4:junit4]   2> 8136 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10059 (1415072086282469376)]} 0 16
[junit4:junit4]   2> 8140 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10060 (1415072086301343744)]} 0 1
[junit4:junit4]   2> 8145 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 8146 T599 C70 P35338 /update {wt=javabin&version=2} {add=[56 (1415072086300295168)]} 0 8
[junit4:junit4]   2> 8148 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8148 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10060 (1415072086305538048)]} 0 5
[junit4:junit4]   2> 8150 T584 C71 P35321 /update {wt=javabin&version=2} {add=[57 (1415072086311829504)]} 0 1
[junit4:junit4]   2> 8152 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10061 (1415072086313926656)]} 0 1
[junit4:junit4]   2> 8157 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8158 T600 C70 P35338 /update {wt=javabin&version=2} {add=[57 (1415072086316023808)]} 0 5
[junit4:junit4]   2> 8160 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8161 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10061 (1415072086318120960)]} 0 6
[junit4:junit4]   2> 8162 T583 C71 P35321 /update {wt=javabin&version=2} {add=[58 (1415072086324412416)]} 0 1
[junit4:junit4]   2> 8165 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10062 (1415072086327558144)]} 0 1
[junit4:junit4]   2> 8170 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8171 T599 C70 P35338 /update {wt=javabin&version=2} {add=[58 (1415072086329655296)]} 0 6
[junit4:junit4]   2> 8176 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[50 (-1415072086339092480)]} 0 1
[junit4:junit4]   2> 8183 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8183 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8184 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[50 (-1415072086343286784)]} 0 5
[junit4:junit4]   2> 8184 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10062 (1415072086331752448)]} 0 16
[junit4:junit4]   2> 8189 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10063 (1415072086352723968)]} 0 2
[junit4:junit4]   2> 8189 T584 C71 P35321 /update {wt=javabin&version=2} {add=[59 (1415072086352723969)]} 0 2
[junit4:junit4]   2> 8198 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8199 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8199 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10063 (1415072086357966848)]} 0 7
[junit4:junit4]   2> 8201 T600 C70 P35338 /update {wt=javabin&version=2} {add=[59 (1415072086357966849)]} 0 9
[junit4:junit4]   2> 8205 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10064 (1415072086369501184)]} 0 2
[junit4:junit4]   2> 8205 T583 C71 P35321 /update {wt=javabin&version=2} {add=[60 (1415072086369501185)]} 0 1
[junit4:junit4]   2> 8213 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8214 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8214 T599 C70 P35338 /update {wt=javabin&version=2} {add=[60 (1415072086374744064)]} 0 6
[junit4:junit4]   2> 8215 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10064 (1415072086374744065)]} 0 7
[junit4:junit4]   2> 8219 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[10052 (-1415072086384181248)]} 0 1
[junit4:junit4]   2> 8219 T583 C71 P35321 /update {wt=javabin&version=2} {add=[61 (1415072086384181249)]} 0 1
[junit4:junit4]   2> 8226 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8226 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[10052 (-1415072086389424128)]} 0 4
[junit4:junit4]   2> 8227 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8228 T599 C70 P35338 /update {wt=javabin&version=2} {add=[61 (1415072086388375552)]} 0 6
[junit4:junit4]   2> 8231 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10065 (1415072086396764160)]} 0 2
[junit4:junit4]   2> 8240 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8241 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10065 (1415072086400958464)]} 0 7
[junit4:junit4]   2> 8242 T584 C71 P35321 /update {wt=javabin&version=2} {add=[62 (1415072086397812736)]} 0 11
[junit4:junit4]   2> 8245 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[10054 (-1415072086412492800)]} 0 1
[junit4:junit4]   2> 8250 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8251 T599 C70 P35338 /update {wt=javabin&version=2} {add=[62 (1415072086412492800)]} 0 6
[junit4:junit4]   2> 8251 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8252 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[10054 (-1415072086415638528)]} 0 4
[junit4:junit4]   2> 8255 T583 C71 P35321 /update {wt=javabin&version=2} {add=[63 (1415072086421929984)]} 0 1
[junit4:junit4]   2> 8258 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10066 (1415072086422978560)]} 0 3
[junit4:junit4]   2> 8261 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8262 T600 C70 P35338 /update {wt=javabin&version=2} {add=[63 (1415072086426124288)]} 0 4
[junit4:junit4]   2> 8267 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8267 T584 C71 P35321 /update {wt=javabin&version=2} {add=[64 (1415072086434512896)]} 0 2
[junit4:junit4]   2> 8267 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10066 (1415072086429270016)]} 0 6
[junit4:junit4]   2> 8272 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10067 (1415072086439755776)]} 0 2
[junit4:junit4]   2> 8283 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8283 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10067 (1415072086444998656)]} 0 8
[junit4:junit4]   2> 8288 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10068 (1415072086456532992)]} 0 1
[junit4:junit4]   2> 8293 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=10 
[junit4:junit4]   2> 8294 T600 C70 P35338 /update {wt=javabin&version=2} {add=[64 (1415072086439755776)]} 0 24
[junit4:junit4]   2> 8298 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[52 (-1415072086468067328)]} 0 1
[junit4:junit4]   2> 8305 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8305 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=11 
[junit4:junit4]   2> 8306 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[52 (-1415072086472261632)]} 0 5
[junit4:junit4]   2> 8306 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10068 (1415072086460727296)]} 0 15
[junit4:junit4]   2> 8310 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[10057 (-1415072086480650240)]} 0 1
[junit4:junit4]   2> 8311 T584 C71 P35321 /update {wt=javabin&version=2} {add=[65 (1415072086480650241)]} 0 2
[junit4:junit4]   2> 8317 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8318 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[10057 (-1415072086484844545)]} 0 5
[junit4:junit4]   2> 8320 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 8321 T600 C70 P35338 /update {wt=javabin&version=2} {add=[65 (1415072086484844544)]} 0 8
[junit4:junit4]   2> 8322 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10069 (1415072086492184576)]} 0 1
[junit4:junit4]   2> 8325 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[54 (-1415072086495330304)]} 0 1
[junit4:junit4]   2> 8329 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8330 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10069 (1415072086496378880)]} 0 5
[junit4:junit4]   2> 8332 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8332 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[54 (-1415072086499524608)]} 0 4
[junit4:junit4]   2> 8333 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[10058 (-1415072086503718912)]} 0 1
[junit4:junit4]   2> 8337 T584 C71 P35321 /update {wt=javabin&version=2} {add=[66 (1415072086507913216)]} 0 2
[junit4:junit4]   2> 8340 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8341 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[10058 (-1415072086507913216)]} 0 4
[junit4:junit4]   2> 8344 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10070 (1415072086515253248)]} 0 1
[junit4:junit4]   2> 8347 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 8348 T600 C70 P35338 /update {wt=javabin&version=2} {add=[66 (1415072086512107520)]} 0 8
[junit4:junit4]   2> 8353 T584 C71 P35321 /update {wt=javabin&version=2} {add=[67 (1415072086524690432)]} 0 2
[junit4:junit4]   2> 8353 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8354 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10070 (1415072086521544704)]} 0 5
[junit4:junit4]   2> 8362 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8363 T600 C70 P35338 /update {wt=javabin&version=2} {add=[67 (1415072086528884736)]} 0 7
[junit4:junit4]   2> 8367 T583 C71 P35321 /update {wt=javabin&version=2} {add=[68 (1415072086539370496)]} 0 1
[junit4:junit4]   2> 8368 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10071 (1415072086529933312)]} 0 11
[junit4:junit4]   2> 8376 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8377 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8377 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10071 (1415072086545661952)]} 0 6
[junit4:junit4]   2> 8378 T600 C70 P35338 /update {wt=javabin&version=2} {add=[68 (1415072086545661953)]} 0 7
[junit4:junit4]   2> 8382 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[57 (-1415072086555099136)]} 0 1
[junit4:junit4]   2> 8383 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10072 (1415072086554050560)]} 0 3
[junit4:junit4]   2> 8389 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8390 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[57 (-1415072086559293440)]} 0 5
[junit4:junit4]   2> 8394 T584 C71 P35321 /update {wt=javabin&version=2} {add=[69 (1415072086567682048)]} 0 1
[junit4:junit4]   2> 8400 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8401 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10072 (1415072086561390592)]} 0 15
[junit4:junit4]   2> 8404 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8404 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[10059 (-1415072086579216384)]} 0 0
[junit4:junit4]   2> 8405 T600 C70 P35338 /update {wt=javabin&version=2} {add=[69 (1415072086573973504)]} 0 7
[junit4:junit4]   2> 8408 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[58 (-1415072086583410688)]} 0 0
[junit4:junit4]   2> 8410 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8411 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[10059 (-1415072086582362112)]} 0 4
[junit4:junit4]   2> 8413 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8414 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[58 (-1415072086586556416)]} 0 3
[junit4:junit4]   2> 8415 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10073 (1415072086589702144)]} 0 1
[junit4:junit4]   2> 8422 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8422 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10073 (1415072086593896448)]} 0 4
[junit4:junit4]   2> 8426 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10074 (1415072086602285056)]} 0 1
[junit4:junit4]   2> 8428 T583 C71 P35321 /update {wt=javabin&version=2} {add=[70 (1415072086592847872)]} 0 11
[junit4:junit4]   2> 8433 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8434 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10074 (1415072086605430784)]} 0 5
[junit4:junit4]   2> 8435 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8436 T599 C70 P35338 /update {wt=javabin&version=2} {add=[70 (1415072086607527936)]} 0 5
[junit4:junit4]   2> 8438 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[10062 (-1415072086613819392)]} 0 1
[junit4:junit4]   2> 8440 T584 C71 P35321 /update {wt=javabin&version=2} {add=[71 (1415072086615916544)]} 0 1
[junit4:junit4]   2> 8443 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8444 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[10062 (-1415072086616965120)]} 0 4
[junit4:junit4]   2> 8446 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8446 T600 C70 P35338 /update {wt=javabin&version=2} {add=[71 (1415072086619062272)]} 0 4
[junit4:junit4]   2> 8448 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10075 (1415072086624305152)]} 0 1
[junit4:junit4]   2> 8451 T583 C71 P35321 /update {wt=javabin&version=2} {add=[72 (1415072086626402304)]} 0 2
[junit4:junit4]   2> 8454 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8454 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10075 (1415072086627450880)]} 0 4
[junit4:junit4]   2> 8458 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10076 (1415072086634790912)]} 0 1
[junit4:junit4]   2> 8462 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=6 
[junit4:junit4]   2> 8463 T599 C70 P35338 /update {wt=javabin&version=2} {add=[72 (1415072086630596608)]} 0 10
[junit4:junit4]   2> 8465 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8465 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10076 (1415072086638985216)]} 0 4
[junit4:junit4]   2> 8466 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[59 (-1415072086644228096)]} 0 0
[junit4:junit4]   2> 8468 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[10063 (-1415072086646325248)]} 0 0
[junit4:junit4]   2> 8472 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8473 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[59 (-1415072086647373824)]} 0 4
[junit4:junit4]   2> 8474 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8475 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[10063 (-1415072086649470976)]} 0 4
[junit4:junit4]   2> 8477 T584 C71 P35321 /update {wt=javabin&version=2} {add=[73 (1415072086654713856)]} 0 1
[junit4:junit4]   2> 8479 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10077 (1415072086656811008)]} 0 1
[junit4:junit4]   2> 8484 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8485 T599 C70 P35338 /update {wt=javabin&version=2} {add=[73 (1415072086657859584)]} 0 6
[junit4:junit4]   2> 8489 T583 C71 P35321 /update {wt=javabin&version=2} {add=[74 (1415072086667296768)]} 0 1
[junit4:junit4]   2> 8498 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8498 T599 C70 P35338 /update {wt=javabin&version=2} {add=[74 (1415072086670442496)]} 0 7
[junit4:junit4]   2> 8501 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[62 (-1415072086680928256)]} 0 0
[junit4:junit4]   2> 8507 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8508 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[62 (-1415072086684073984)]} 0 4
[junit4:junit4]   2> 8512 T583 C71 P35321 /update {wt=javabin&version=2} {add=[75 (1415072086691414016)]} 0 1
[junit4:junit4]   2> 8519 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8520 T599 C70 P35338 /update {wt=javabin&version=2} {add=[75 (1415072086695608320)]} 0 6
[junit4:junit4]   2> 8524 T583 C71 P35321 /update {wt=javabin&version=2} {add=[76 (1415072086703996928)]} 0 1
[junit4:junit4]   2> 8531 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8532 T599 C70 P35338 /update {wt=javabin&version=2} {add=[76 (1415072086708191232)]} 0 6
[junit4:junit4]   2> 8535 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[63 (-1415072086716579840)]} 0 0
[junit4:junit4]   2> 8541 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8542 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[63 (-1415072086719725568)]} 0 4
[junit4:junit4]   2> 8547 T583 C71 P35321 /update {wt=javabin&version=2} {add=[77 (1415072086728114176)]} 0 1
[junit4:junit4]   2> 8548 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8549 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10077 (1415072086659956736)]} 0 68
[junit4:junit4]   2> 8553 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10078 (1415072086734405632)]} 0 1
[junit4:junit4]   2> 8554 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8554 T599 C70 P35338 /update {wt=javabin&version=2} {add=[77 (1415072086732308480)]} 0 4
[junit4:junit4]   2> 8558 T583 C71 P35321 /update {wt=javabin&version=2} {add=[78 (1415072086739648512)]} 0 1
[junit4:junit4]   2> 8560 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8560 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10078 (1415072086738599936)]} 0 4
[junit4:junit4]   2> 8565 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8565 T599 C70 P35338 /update {wt=javabin&version=2} {add=[78 (1415072086743842816)]} 0 4
[junit4:junit4]   2> 8569 T584 C71 P35321 /update {wt=javabin&version=2} {add=[79 (1415072086751182848)]} 0 1
[junit4:junit4]   2> 8576 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8576 T599 C70 P35338 /update {wt=javabin&version=2} {add=[79 (1415072086755377152)]} 0 4
[junit4:junit4]   2> 8580 T584 C71 P35321 /update {wt=javabin&version=2} {add=[80 (1415072086762717184)]} 0 1
[junit4:junit4]   2> 8621 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10079 (1415072086745939968)]} 0 58
[junit4:junit4]   2> 8628 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8628 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10079 (1415072086809903104)]} 0 4
[junit4:junit4]   2> 8634 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10080 (1415072086817243136)]} 0 3
[junit4:junit4]   2> 8648 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8648 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10080 (1415072086823534592)]} 0 11
[junit4:junit4]   2> 8649 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=63 
[junit4:junit4]   2> 8650 T599 C70 P35338 /update {wt=javabin&version=2} {add=[80 (1415072086765862912)]} 0 68
[junit4:junit4]   2> 8653 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10081 (1415072086839263233)]} 0 1
[junit4:junit4]   2> 8660 T584 C71 P35321 /update {wt=javabin&version=2} {add=[81 (1415072086839263232)]} 0 8
[junit4:junit4]   2> 8663 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8663 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10081 (1415072086843457536)]} 0 7
[junit4:junit4]   2> 8666 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[10065 (-1415072086853943296)]} 0 0
[junit4:junit4]   2> 8667 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8667 T600 C70 P35338 /update {wt=javabin&version=2} {add=[81 (1415072086850797568)]} 0 4
[junit4:junit4]   2> 8670 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[65 (-1415072086858137600)]} 0 0
[junit4:junit4]   2> 8671 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8672 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[10065 (-1415072086857089024)]} 0 3
[junit4:junit4]   2> 8676 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8676 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10082 (1415072086862331904)]} 0 2
[junit4:junit4]   2> 8676 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[65 (-1415072086861283328)]} 0 3
[junit4:junit4]   2> 8680 T584 C71 P35321 /update {wt=javabin&version=2} {add=[82 (1415072086867574784)]} 0 1
[junit4:junit4]   2> 8683 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8684 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10082 (1415072086867574784)]} 0 5
[junit4:junit4]   2> 8687 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8687 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[10066 (-1415072086875963392)]} 0 0
[junit4:junit4]   2> 8688 T600 C70 P35338 /update {wt=javabin&version=2} {add=[82 (1415072086871769088)]} 0 5
[junit4:junit4]   2> 8690 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[66 (-1415072086879109120)]} 0 0
[junit4:junit4]   2> 8692 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8693 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[10066 (-1415072086879109120)]} 0 3
[junit4:junit4]   2> 8695 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8696 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[66 (-1415072086882254848)]} 0 3
[junit4:junit4]   2> 8697 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10083 (1415072086885400576)]} 0 1
[junit4:junit4]   2> 8700 T583 C71 P35321 /update {wt=javabin&version=2} {add=[83 (1415072086888546304)]} 0 1
[junit4:junit4]   2> 8704 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8705 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10083 (1415072086889594880)]} 0 5
[junit4:junit4]   2> 8707 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8707 T599 C70 P35338 /update {wt=javabin&version=2} {add=[83 (1415072086892740608)]} 0 4
[junit4:junit4]   2> 8708 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10084 (1415072086896934912)]} 0 1
[junit4:junit4]   2> 8711 T584 C71 P35321 /update {wt=javabin&version=2} {add=[84 (1415072086900080640)]} 0 1
[junit4:junit4]   2> 8718 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8719 T600 C70 P35338 /update {wt=javabin&version=2} {add=[84 (1415072086904274944)]} 0 5
[junit4:junit4]   2> 8721 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[68 (-1415072086911614976)]} 0 0
[junit4:junit4]   2> 8727 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=13 
[junit4:junit4]   2> 8727 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8728 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10084 (1415072086901129216)]} 0 17
[junit4:junit4]   2> 8728 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[68 (-1415072086914760704)]} 0 4
[junit4:junit4]   2> 8731 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[10068 (-1415072086922100736)]} 0 0
[junit4:junit4]   2> 8732 T583 C71 P35321 /update {wt=javabin&version=2} {add=[85 (1415072086922100737)]} 0 1
[junit4:junit4]   2> 8736 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8737 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[10068 (-1415072086925246464)]} 0 3
[junit4:junit4]   2> 8740 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8741 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10085 (1415072086931537920)]} 0 1
[junit4:junit4]   2> 8741 T599 C70 P35338 /update {wt=javabin&version=2} {add=[85 (1415072086926295040)]} 0 6
[junit4:junit4]   2> 8745 T583 C71 P35321 /update {wt=javabin&version=2} {add=[86 (1415072086935732224)]} 0 1
[junit4:junit4]   2> 8753 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8753 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8754 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10085 (1415072086934683648)]} 0 11
[junit4:junit4]   2> 8754 T600 C70 P35338 /update {wt=javabin&version=2} {add=[86 (1415072086939926528)]} 0 6
[junit4:junit4]   2> 8757 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10086 (1415072086948315136)]} 0 1
[junit4:junit4]   2> 8757 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[69 (-1415072086949363712)]} 0 0
[junit4:junit4]   2> 8762 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8763 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8763 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[69 (-1415072086952509440)]} 0 3
[junit4:junit4]   2> 8763 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10086 (1415072086951460864)]} 0 4
[junit4:junit4]   2> 8766 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[10069 (-1415072086958800896)]} 0 0
[junit4:junit4]   2> 8767 T584 C71 P35321 /update {wt=javabin&version=2} {add=[87 (1415072086958800897)]} 0 1
[junit4:junit4]   2> 8771 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8772 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[10069 (-1415072086961946624)]} 0 3
[junit4:junit4]   2> 8774 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8774 T599 C70 P35338 /update {wt=javabin&version=2} {add=[87 (1415072086962995200)]} 0 4
[junit4:junit4]   2> 8776 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10087 (1415072086968238080)]} 0 1
[junit4:junit4]   2> 8778 T583 C71 P35321 /update {wt=javabin&version=2} {add=[88 (1415072086970335232)]} 0 1
[junit4:junit4]   2> 8783 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8783 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10087 (1415072086972432384)]} 0 4
[junit4:junit4]   2> 8784 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8784 T600 C70 P35338 /update {wt=javabin&version=2} {add=[88 (1415072086973480960)]} 0 4
[junit4:junit4]   2> 8788 T584 C71 P35321 /update {wt=javabin&version=2} {add=[89 (1415072086980820992)]} 0 1
[junit4:junit4]   2> 8792 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10088 (1415072086979772416)]} 0 6
[junit4:junit4]   2> 8799 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8799 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10088 (1415072086989209600)]} 0 4
[junit4:junit4]   2> 8803 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=9 
[junit4:junit4]   2> 8803 T600 C70 P35338 /update {wt=javabin&version=2} {add=[89 (1415072086985015296)]} 0 12
[junit4:junit4]   2> 8804 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10089 (1415072086996549632)]} 0 2
[junit4:junit4]   2> 8806 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[75 (-1415072087000743936)]} 0 0
[junit4:junit4]   2> 8811 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8812 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[75 (-1415072087003889664)]} 0 3
[junit4:junit4]   2> 8812 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8813 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10089 (1415072087001792512)]} 0 6
[junit4:junit4]   2> 8815 T584 C71 P35321 /update {wt=javabin&version=2} {add=[90 (1415072087009132544)]} 0 1
[junit4:junit4]   2> 8816 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[10075 (-1415072087011229696)]} 0 0
[junit4:junit4]   2> 8822 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8822 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8822 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[10075 (-1415072087014375424)]} 0 3
[junit4:junit4]   2> 8823 T600 C70 P35338 /update {wt=javabin&version=2} {add=[90 (1415072087013326848)]} 0 5
[junit4:junit4]   2> 8826 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10090 (1415072087020666880)]} 0 1
[junit4:junit4]   2> 8827 T584 C71 P35321 /update {wt=javabin&version=2} {add=[91 (1415072087021715456)]} 0 1
[junit4:junit4]   2> 8835 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8836 T599 C70 P35338 /update {wt=javabin&version=2} {add=[91 (1415072087025909760)]} 0 6
[junit4:junit4]   2> 8840 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8840 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10090 (1415072087024861184)]} 0 11
[junit4:junit4]   2> 8844 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10091 (1415072087039541248)]} 0 1
[junit4:junit4]   2> 8846 T584 C71 P35321 /update {wt=javabin&version=2} {add=[92 (1415072087034298368)]} 0 8
[junit4:junit4]   2> 8851 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8851 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10091 (1415072087043735552)]} 0 4
[junit4:junit4]   2> 8853 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8853 T599 C70 P35338 /update {wt=javabin&version=2} {add=[92 (1415072087045832704)]} 0 4
[junit4:junit4]   2> 8856 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10092 (1415072087051075584)]} 0 2
[junit4:junit4]   2> 8857 T583 C71 P35321 /update {wt=javabin&version=2} {add=[93 (1415072087053172736)]} 0 1
[junit4:junit4]   2> 8863 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8863 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10092 (1415072087056318464)]} 0 4
[junit4:junit4]   2> 8864 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8864 T600 C70 P35338 /update {wt=javabin&version=2} {add=[93 (1415072087057367040)]} 0 4
[junit4:junit4]   2> 8867 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10093 (1415072087063658496)]} 0 1
[junit4:junit4]   2> 8868 T584 C71 P35321 /update {wt=javabin&version=2} {add=[94 (1415072087064707072)]} 0 1
[junit4:junit4]   2> 8874 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8874 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10093 (1415072087067852800)]} 0 4
[junit4:junit4]   2> 8875 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8875 T599 C70 P35338 /update {wt=javabin&version=2} {add=[94 (1415072087068901376)]} 0 4
[junit4:junit4]   2> 8878 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10094 (1415072087075192832)]} 0 1
[junit4:junit4]   2> 8879 T583 C71 P35321 /update {wt=javabin&version=2} {add=[95 (1415072087076241408)]} 0 1
[junit4:junit4]   2> 8885 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8885 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10094 (1415072087079387136)]} 0 4
[junit4:junit4]   2> 8886 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8886 T600 C70 P35338 /update {wt=javabin&version=2} {add=[95 (1415072087080435712)]} 0 4
[junit4:junit4]   2> 8889 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10095 (1415072087086727168)]} 0 1
[junit4:junit4]   2> 8889 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[76 (-1415072087087775744)]} 0 0
[junit4:junit4]   2> 8894 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8895 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[76 (-1415072087090921472)]} 0 3
[junit4:junit4]   2> 8899 T584 C71 P35321 /update {wt=javabin&version=2} {add=[96 (1415072087097212928)]} 0 1
[junit4:junit4]   2> 8903 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8904 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10095 (1415072087090921473)]} 0 12
[junit4:junit4]   2> 8906 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[10076 (-1415072087105601536)]} 0 0
[junit4:junit4]   2> 8911 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8912 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=6 
[junit4:junit4]   2> 8912 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[10076 (-1415072087108747264)]} 0 3
[junit4:junit4]   2> 8912 T599 C70 P35338 /update {wt=javabin&version=2} {add=[96 (1415072087101407232)]} 0 10
[junit4:junit4]   2> 8916 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10096 (1415072087115038720)]} 0 1
[junit4:junit4]   2> 8916 T583 C71 P35321 /update {wt=javabin&version=2} {add=[97 (1415072087116087296)]} 0 1
[junit4:junit4]   2> 8924 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8925 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10096 (1415072087119233024)]} 0 6
[junit4:junit4]   2> 8928 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10097 (1415072087127621632)]} 0 1
[junit4:junit4]   2> 8929 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=6 
[junit4:junit4]   2> 8929 T600 C70 P35338 /update {wt=javabin&version=2} {add=[97 (1415072087120281600)]} 0 9
[junit4:junit4]   2> 8935 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8936 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10097 (1415072087130767360)]} 0 6
[junit4:junit4]   2> 8940 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10098 (1415072087140204544)]} 0 1
[junit4:junit4]   2> 8940 T583 C71 P35321 /update {wt=javabin&version=2} {add=[98 (1415072087132864512)]} 0 8
[junit4:junit4]   2> 8947 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8947 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10098 (1415072087144398848)]} 0 4
[junit4:junit4]   2> 8948 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8949 T600 C70 P35338 /update {wt=javabin&version=2} {add=[98 (1415072087144398849)]} 0 6
[junit4:junit4]   2> 8952 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[10077 (-1415072087153836032)]} 0 1
[junit4:junit4]   2> 8954 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[77 (-1415072087154884608)]} 0 1
[junit4:junit4]   2> 8959 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8959 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[10077 (-1415072087156981760)]} 0 4
[junit4:junit4]   2> 8959 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8960 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[77 (-1415072087158030336)]} 0 4
[junit4:junit4]   2> 8963 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10099 (1415072087164321792)]} 0 1
[junit4:junit4]   2> 8965 T583 C71 P35321 /update {wt=javabin&version=2} {add=[99 (1415072087165370368)]} 0 2
[junit4:junit4]   2> 8970 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8970 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10099 (1415072087168516096)]} 0 4
[junit4:junit4]   2> 8972 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8973 T600 C70 P35338 /update {wt=javabin&version=2} {add=[99 (1415072087170613248)]} 0 4
[junit4:junit4]   2> 8973 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[10078 (-1415072087175856128)]} 0 0
[junit4:junit4]   2> 8975 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[78 (-1415072087177953280)]} 0 0
[junit4:junit4]   2> 8978 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8979 T600 C70 P35338 /update {wt=javabin&version=2} {delete=[10078 (-1415072087179001856)]} 0 3
[junit4:junit4]   2> 8981 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8982 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[78 (-1415072087181099008)]} 0 4
[junit4:junit4]   2> 8983 T584 C71 P35321 /update {wt=javabin&version=2} {add=[10100 (1415072087185293312)]} 0 1
[junit4:junit4]   2> 8986 T583 C71 P35321 /update {wt=javabin&version=2} {add=[100 (1415072087188439040)]} 0 1
[junit4:junit4]   2> 8990 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8990 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10100 (1415072087189487616)]} 0 4
[junit4:junit4]   2> 8993 T583 C71 P35321 /update {wt=javabin&version=2} {delete=[10079 (-1415072087196827648)]} 0 0
[junit4:junit4]   2> 9000 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 9000 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 9000 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[10079 (-1415072087199973376)]} 0 4
[junit4:junit4]   2> 9001 T600 C70 P35338 /update {wt=javabin&version=2} {add=[100 (1415072087192633344)]} 0 12
[junit4:junit4]   2> 9004 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10101 (1415072087207313408)]} 0 1
[junit4:junit4]   2> 9004 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[79 (-1415072087208361984)]} 0 0
[junit4:junit4]   2> 9010 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 9011 T599 C70 P35338 /update {wt=javabin&version=2} {delete=[79 (-1415072087211507712)]} 0 4
[junit4:junit4]   2> 9012 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 9012 T600 C70 P35338 /update {wt=javabin&version=2} {add=[10101 (1415072087210459136)]} 0 6
[junit4:junit4]   2> 9015 T584 C71 P35321 /update {wt=javabin&version=2} {add=[101 (1415072087218847744)]} 0 1
[junit4:junit4]   2> 9016 T583 C71 P35321 /update {wt=javabin&version=2} {add=[10102 (1415072087219896320)]} 0 1
[junit4:junit4]   2> 9022 T610 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 9022 T600 C70 P35338 /update {wt=javabin&version=2} {add=[101 (1415072087223042048)]} 0 4
[junit4:junit4]   2> 9023 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 9024 T599 C70 P35338 /update {wt=javabin&version=2} {add=[10102 (1415072087224090624)]} 0 6
[junit4:junit4]   2> 9026 T583 C71 P35321 /update {wt=javabin&version=2} {add=[102 (1415072087230382080)]} 0 1
[junit4:junit4]   2> 9027 T584 C71 P35321 /update {wt=javabin&version=2} {delete=[10080 (-1415072087232479232)]} 0 0
[junit4:junit4]   2> 9032 T609 C69 P35349 REQ /update {distrib.from=http://127.0.0.1:35338/solr/collection1/&update.distrib=FROMLEADE

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

 _2y_Lucene40_0.prx, _32.fdt, _31_Lucene40_0.tip, _33_Lucene40_0.frq, _30_nrm.cfe, segments_3, _2z.fdt, _2y_2.del]
[junit4:junit4]   2> 		commit{dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1349517896435/jetty1/index,segFN=segments_4,generation=4,filenames=[_34.si, _34_nrm.cfe, _34_Lucene40_0.prx, _34_nrm.cfs, _34_Lucene40_0.frq, _34.fdx, _34_Lucene40_0.tim, _34_Lucene40_0.tip, _34.fnm, _34.fdt, segments_4]
[junit4:junit4]   2> 30408 T571 C70 P35338 oasc.SolrDeletionPolicy.updateCommits newest commit = 4
[junit4:junit4]   2> 30446 T571 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 30550 T605 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 30550 T571 oaz.ZooKeeper.close Session: 0x13a3588eaf90003 closed
[junit4:junit4]   2> 30551 T571 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 30604 T571 oasc.ChaosMonkey.monkeyLog monkey: stop shard! 35349
[junit4:junit4]   2> 30604 T571 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1663879661
[junit4:junit4]   2> 30706 T672 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 30706 T571 oaz.ZooKeeper.close Session: 0x13a3588eaf90007 closed
[junit4:junit4]   2> 30707 T571 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 30853 T571 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=RecoveryZkTest -Dtests.method=testDistribSearch -Dtests.seed=4B6FEF58067C8C68 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sq_AL -Dtests.timezone=America/Detroit -Dtests.file.encoding=US-ASCII
[junit4:junit4] ERROR   30.9s J1 | RecoveryZkTest.testDistribSearch <<<
[junit4:junit4]    > Throwable #1: org.apache.solr.common.SolrException: Server at http://127.0.0.1:35349/solr/collection1 returned non ok status:404, message:Can not find: /solr/collection1/select
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([4B6FEF58067C8C68:CA8961407123EC54]:0)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:372)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:181)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:90)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:301)
[junit4:junit4]    > 	at org.apache.solr.cloud.RecoveryZkTest.doTest(RecoveryZkTest.java:92)
[junit4:junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:695)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
[junit4:junit4]    > 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4:junit4]    > 	at java.lang.reflect.Method.invoke(Method.java:601)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 30878 T571 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4]   2> NOTE: test params are: codec=Compressing, sim=DefaultSimilarity, locale=sq_AL, timezone=America/Detroit
[junit4:junit4]   2> NOTE: FreeBSD 9.0-RELEASE amd64/Oracle Corporation 1.7.0_06 (64-bit)/cpus=16,threads=1,free=285170480,total=458227712
[junit4:junit4]   2> NOTE: All tests run in this JVM: [TestSolrDeletionPolicy2, XsltUpdateRequestHandlerTest, FieldMutatingUpdateProcessorTest, LegacyHTMLStripCharFilterTest, ReturnFieldsTest, ConvertedLegacyTest, MultiTermTest, TestSolrCoreProperties, TestDFRSimilarityFactory, TestDocumentBuilder, TestMultiCoreConfBootstrap, DistributedQueryElevationComponentTest, OpenExchangeRatesOrgProviderTest, TestReload, ShowFileRequestHandlerTest, TestOmitPositions, IndexSchemaTest, TestFoldingMultitermQuery, TestHashPartitioner, TestBinaryField, TestSolrDeletionPolicy1, TimeZoneUtilsTest, StandardRequestHandlerTest, TestJmxIntegration, PrimUtilsTest, SpellingQueryConverterTest, ClusterStateUpdateTest, ScriptEngineTest, DocumentAnalysisRequestHandlerTest, TestPropInjectDefaults, TestCodecSupport, SolrInfoMBeanTest, TestQueryUtils, TestArbitraryIndexDir, FullSolrCloudDistribCmdsTest, TestSolrXMLSerializer, SignatureUpdateProcessorFactoryTest, TestCSVLoader, SyncSliceTest, DocumentBuilderTest, RecoveryZkTest]
[junit4:junit4] Completed on J1 in 30.91s, 1 test, 1 error <<< FAILURES!

[...truncated 400 lines...]
BUILD FAILED
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/build.xml:38: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build.xml:180: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/lucene/module-build.xml:61: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/lucene/common-build.xml:1143: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/lucene/common-build.xml:816: There were test failures: 230 suites, 956 tests, 1 error, 21 ignored (3 assumptions)

Total time: 30 minutes 44 seconds
Build step 'Invoke Ant' marked build as failure
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure



Mime
View raw message