lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@sd-datasolutions.de>
Subject [JENKINS] Lucene-Solr-4.x-Linux (32bit/jdk1.6.0_35) - Build # 1257 - Failure!
Date Fri, 21 Sep 2012 14:35:35 GMT
Build: http://jenkins.sd-datasolutions.de/job/Lucene-Solr-4.x-Linux/1257/
Java: 32bit/jdk1.6.0_35 -server -XX:+UseParallelGC

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

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




Build Log:
[...truncated 7134 lines...]
[junit4:junit4] Suite: org.apache.solr.cloud.RecoveryZkTest
[junit4:junit4]   2> 3 T1270 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4:junit4]   2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-RecoveryZkTest-1348237725073
[junit4:junit4]   2> 4 T1270 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4]   2> 5 T1271 oazs.ZooKeeperServer.setTickTime tickTime set to 1000
[junit4:junit4]   2> 5 T1271 oazs.NIOServerCnxn$Factory.<init> binding to port 0.0.0.0/0.0.0.0:0
[junit4:junit4]   2> 5 T1271 oazsp.FileTxnSnapLog.save Snapshotting: 0
[junit4:junit4]   2> 104 T1270 oasc.ZkTestServer.run start zk server on port:50979
[junit4:junit4]   2> 105 T1270 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:50979 sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@1ca8038
[junit4:junit4]   2> 105 T1276 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:50979
[junit4:junit4]   2> 105 T1270 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 106 T1276 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:50979, initiating session
[junit4:junit4]   2> 106 T1272 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:56986
[junit4:junit4]   2> 106 T1272 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:56986
[junit4:junit4]   2> 106 T1274 oazsp.FileTxnLog.append Creating new log file: log.1
[junit4:junit4]   2> 303 T1274 oazs.NIOServerCnxn.finishSessionInit Established session 0x139e93b0d940000 with negotiated timeout 10000 for client /127.0.0.1:56986
[junit4:junit4]   2> 303 T1276 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:50979, sessionid = 0x139e93b0d940000, negotiated timeout = 10000
[junit4:junit4]   2> 304 T1277 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1ca8038 name:ZooKeeperConnection Watcher:127.0.0.1:50979 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 304 T1270 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 304 T1270 oascc.SolrZkClient.makePath makePath: /solr
[junit4:junit4]   2> 305 T1275 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x139e93b0d940000
[junit4:junit4]   2> 306 T1277 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 306 T1272 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:56986 which had sessionid 0x139e93b0d940000
[junit4:junit4]   2> 306 T1270 oaz.ZooKeeper.close Session: 0x139e93b0d940000 closed
[junit4:junit4]   2> 307 T1270 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:50979/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@36a6d1
[junit4:junit4]   2> 307 T1278 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:50979
[junit4:junit4]   2> 307 T1270 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 308 T1278 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:50979, initiating session
[junit4:junit4]   2> 308 T1272 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:56987
[junit4:junit4]   2> 308 T1272 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:56987
[junit4:junit4]   2> 309 T1274 oazs.NIOServerCnxn.finishSessionInit Established session 0x139e93b0d940001 with negotiated timeout 10000 for client /127.0.0.1:56987
[junit4:junit4]   2> 309 T1278 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:50979, sessionid = 0x139e93b0d940001, negotiated timeout = 10000
[junit4:junit4]   2> 309 T1279 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@36a6d1 name:ZooKeeperConnection Watcher:127.0.0.1:50979/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 309 T1270 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 309 T1270 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4:junit4]   2> 319 T1270 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4:junit4]   2> 320 T1270 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4:junit4]   2> 322 T1270 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4:junit4]   2> 323 T1270 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 323 T1270 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 338 T1270 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4:junit4]   2> 339 T1270 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4:junit4]   2> 341 T1270 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 342 T1270 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 344 T1270 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4:junit4]   2> 344 T1270 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
[junit4:junit4]   2> 345 T1270 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4:junit4]   2> 346 T1270 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
[junit4:junit4]   2> 347 T1270 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4:junit4]   2> 347 T1270 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
[junit4:junit4]   2> 349 T1270 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 349 T1270 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 360 T1270 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 361 T1270 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 378 T1270 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 379 T1270 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 382 T1270 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4:junit4]   2> 382 T1270 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
[junit4:junit4]   2> 384 T1275 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x139e93b0d940001
[junit4:junit4]   2> 385 T1272 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:56987 which had sessionid 0x139e93b0d940001
[junit4:junit4]   2> 385 T1270 oaz.ZooKeeper.close Session: 0x139e93b0d940001 closed
[junit4:junit4]   2> 387 T1270 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 387 T1279 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 390 T1270 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:52213
[junit4:junit4]   2> 391 T1270 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 391 T1270 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 392 T1270 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 404 T1270 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 404 T1270 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 404 T1270 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 405 T1270 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 405 T1270 oasc.CoreContainer.<init> New CoreContainer 6180628
[junit4:junit4]   2> 405 T1270 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 406 T1270 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 418 T1270 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 426 T1270 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:50979/solr
[junit4:junit4]   2> 427 T1270 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:50979/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@32d521
[junit4:junit4]   2> 427 T1289 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:50979
[junit4:junit4]   2> 427 T1270 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 428 T1289 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:50979, initiating session
[junit4:junit4]   2> 428 T1272 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:56988
[junit4:junit4]   2> 428 T1272 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:56988
[junit4:junit4]   2> 430 T1274 oazs.NIOServerCnxn.finishSessionInit Established session 0x139e93b0d940002 with negotiated timeout 5000 for client /127.0.0.1:56988
[junit4:junit4]   2> 430 T1289 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:50979, sessionid = 0x139e93b0d940002, negotiated timeout = 5000
[junit4:junit4]   2> 430 T1290 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@32d521 name:ZooKeeperConnection Watcher:127.0.0.1:50979/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 430 T1270 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 431 T1275 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139e93b0d940002 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 432 T1270 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4:junit4]   2> 433 T1270 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52213_solr
[junit4:junit4]   2> 433 T1275 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139e93b0d940002 type:delete cxid:0x7 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:52213_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:52213_solr
[junit4:junit4]   2> 434 T1270 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:52213_solr
[junit4:junit4]   2> 435 T1270 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 435 T1270 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 435 T1270 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 436 T1270 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 436 T1270 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 436 T1270 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 437 T1270 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 437 T1270 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 437 T1270 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 438 T1270 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 441 T1270 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4:junit4]   2> 444 T1275 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139e93b0d940002 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> 445 T1270 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4]   2> 459 T1270 oasc.Overseer.start Overseer (id=88358107550580738-127.0.0.1:52213_solr-n_0000000000) starting
[junit4:junit4]   2> 460 T1275 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139e93b0d940002 type:create cxid:0x1a zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 460 T1275 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139e93b0d940002 type:create cxid:0x1b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 461 T1275 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139e93b0d940002 type:create cxid:0x1c zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 462 T1275 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139e93b0d940002 type:create cxid:0x1d zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 462 T1292 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
[junit4:junit4]   2> 463 T1270 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4:junit4]   2> 464 T1270 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 465 T1291 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4]   2> 469 T1270 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 469 T1270 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection
[junit4:junit4]   2> 470 T1270 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 470 T1270 oasc.ZkController.readConfigName Load collection config from:/collections/control_collection
[junit4:junit4]   2> 471 T1270 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 472 T1270 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 473 T1270 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 510 T1270 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_40
[junit4:junit4]   2> 557 T1270 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 557 T1270 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 563 T1270 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 920 T1270 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 929 T1270 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 933 T1270 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 943 T1270 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 946 T1270 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 949 T1270 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 951 T1270 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 952 T1270 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1348237725073/control/data/
[junit4:junit4]   2> 952 T1270 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@75f5b7
[junit4:junit4]   2> 959 T1270 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1348237725073/control/data/index/
[junit4:junit4]   2> 959 T1270 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1348237725073/control/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 960 T1270 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-1348237725073/control/data/index forceNew:false
[junit4:junit4]   2> 1341 T1270 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1348237725073/control/data/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 1341 T1270 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 1342 T1270 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 1344 T1270 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 1345 T1270 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 1345 T1270 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 1346 T1270 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 1346 T1270 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 1347 T1270 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 1347 T1270 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 1348 T1270 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 1349 T1270 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 1349 T1270 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 1350 T1270 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 1350 T1270 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 1351 T1270 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 1351 T1270 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 1352 T1270 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 1352 T1270 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 1353 T1270 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1353 T1270 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1353 T1270 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1354 T1270 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1354 T1270 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1355 T1270 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1355 T1270 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1356 T1270 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 1356 T1270 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 1357 T1270 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 1359 T1270 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 1360 T1270 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> 1362 T1270 oass.SolrIndexSearcher.<init> Opening Searcher@dad531 main
[junit4:junit4]   2> 1362 T1270 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 1363 T1270 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 1363 T1270 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 1620 T1270 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 1976 T1293 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@dad531 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 1980 T1275 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139e93b0d940002 type:create cxid:0x59 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer/queue Error:KeeperErrorCode = NoNode for /solr/overseer/queue
[junit4:junit4]   2> 1982 T1270 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 1982 T1270 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:52213/solr shardId:control_shard
[junit4:junit4]   2> 1983 T1270 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/control_shard/election
[junit4:junit4]   2> 1986 T1275 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139e93b0d940002 type:delete cxid:0x68 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> 1989 T1270 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 1990 T1275 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139e93b0d940002 type:create cxid:0x69 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2470 T1291 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2471 T1275 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139e93b0d940002 type:create cxid:0x70 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer/queue-work Error:KeeperErrorCode = NoNode for /solr/overseer/queue-work
[junit4:junit4]   2> 2475 T1290 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 2494 T1270 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4]   2> 2494 T1270 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 2494 T1270 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:52213/solr/collection1/
[junit4:junit4]   2> 2495 T1270 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4:junit4]   2> 2495 T1270 oasc.SyncStrategy.syncToMe http://127.0.0.1:52213/solr/collection1/ has no replicas
[junit4:junit4]   2> 2495 T1270 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:52213/solr/collection1/
[junit4:junit4]   2> 2496 T1270 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/control_shard
[junit4:junit4]   2> 2501 T1275 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139e93b0d940002 type:create cxid:0x8e zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2978 T1291 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3040 T1290 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3089 T1270 oasc.ZkController.register We are http://127.0.0.1:52213/solr/collection1/ and leader is http://127.0.0.1:52213/solr/collection1/
[junit4:junit4]   2> 3090 T1270 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:52213/solr
[junit4:junit4]   2> 3090 T1270 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4]   2> 3099 T1270 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3100 T1270 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1
[junit4:junit4]   2> 3100 T1270 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 3101 T1270 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 3148 T1270 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 3150 T1270 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:59023
[junit4:junit4]   2> 3150 T1270 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 3150 T1270 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-jetty1-1348237728173
[junit4:junit4]   2> 3151 T1270 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-jetty1-1348237728173/'
[junit4:junit4]   2> 3162 T1270 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 3162 T1270 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 3163 T1270 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-jetty1-1348237728173
[junit4:junit4]   2> 3163 T1270 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-jetty1-1348237728173/solr.xml
[junit4:junit4]   2> 3163 T1270 oasc.CoreContainer.<init> New CoreContainer 25587591
[junit4:junit4]   2> 3163 T1270 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-jetty1-1348237728173/'
[junit4:junit4]   2> 3164 T1270 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-jetty1-1348237728173/'
[junit4:junit4]   2> 3175 T1270 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 3183 T1270 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:50979/solr
[junit4:junit4]   2> 3184 T1270 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:50979/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@ed862c
[junit4:junit4]   2> 3184 T1303 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:50979
[junit4:junit4]   2> 3184 T1270 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 3185 T1303 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:50979, initiating session
[junit4:junit4]   2> 3185 T1272 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:56989
[junit4:junit4]   2> 3185 T1272 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:56989
[junit4:junit4]   2> 3200 T1274 oazs.NIOServerCnxn.finishSessionInit Established session 0x139e93b0d940003 with negotiated timeout 5000 for client /127.0.0.1:56989
[junit4:junit4]   2> 3200 T1303 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:50979, sessionid = 0x139e93b0d940003, negotiated timeout = 5000
[junit4:junit4]   2> 3200 T1304 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@ed862c name:ZooKeeperConnection Watcher:127.0.0.1:50979/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 3201 T1270 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 3201 T1275 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139e93b0d940003 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3220 T1275 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139e93b0d940003 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3240 T1270 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59023_solr
[junit4:junit4]   2> 3241 T1275 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139e93b0d940003 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:59023_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:59023_solr
[junit4:junit4]   2> 3241 T1270 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:59023_solr
[junit4:junit4]   2> 3243 T1290 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 3243 T1270 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 3244 T1270 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 3244 T1270 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 3244 T1270 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 3245 T1270 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 3245 T1270 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 3246 T1270 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 3246 T1270 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 3247 T1270 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 3247 T1270 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 3262 T1270 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 3265 T1270 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-jetty1-1348237728173/collection1
[junit4:junit4]   2> 3266 T1270 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 3266 T1270 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 3267 T1270 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 3267 T1270 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-jetty1-1348237728173/collection1/'
[junit4:junit4]   2> 3268 T1270 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-jetty1-1348237728173/collection1/lib/README' to classloader
[junit4:junit4]   2> 3268 T1270 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-jetty1-1348237728173/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 3298 T1270 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_40
[junit4:junit4]   2> 3355 T1270 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 3360 T1270 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 3369 T1270 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 3561 T1291 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3570 T1304 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3570 T1290 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3844 T1270 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 3850 T1270 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 3853 T1270 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 3862 T1270 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 3865 T1270 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 3868 T1270 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 3869 T1270 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 3870 T1270 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-jetty1-1348237728173/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1348237725073/jetty1/
[junit4:junit4]   2> 3870 T1270 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@75f5b7
[junit4:junit4]   2> 3871 T1270 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1348237725073/jetty1/index/
[junit4:junit4]   2> 3871 T1270 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1348237725073/jetty1/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 3872 T1270 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-1348237725073/jetty1/index forceNew:false
[junit4:junit4]   2> 4333 T1270 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1348237725073/jetty1/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 4333 T1270 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 4334 T1270 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 4336 T1270 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 4336 T1270 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 4336 T1270 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 4337 T1270 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 4337 T1270 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 4338 T1270 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 4338 T1270 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 4339 T1270 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 4339 T1270 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 4340 T1270 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 4340 T1270 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 4341 T1270 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 4341 T1270 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 4341 T1270 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 4342 T1270 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 4342 T1270 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 4343 T1270 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4343 T1270 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4344 T1270 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4344 T1270 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4345 T1270 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4345 T1270 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4346 T1270 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4346 T1270 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 4347 T1270 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 4348 T1270 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 4349 T1270 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 4350 T1270 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> 4352 T1270 oass.SolrIndexSearcher.<init> Opening Searcher@1044d87 main
[junit4:junit4]   2> 4353 T1270 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 4353 T1270 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 4354 T1270 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 4410 T1270 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 4937 T1305 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1044d87 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 5077 T1291 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 5098 T1304 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5098 T1290 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5443 T1270 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 5443 T1270 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:59023/solr shardId:shard1
[junit4:junit4]   2> 5444 T1270 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election
[junit4:junit4]   2> 5450 T1275 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139e93b0d940003 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> 5450 T1270 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 5451 T1275 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139e93b0d940003 type:create cxid:0x44 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5452 T1270 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4]   2> 5452 T1270 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 5452 T1270 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:59023/solr/collection1/
[junit4:junit4]   2> 5453 T1270 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4:junit4]   2> 5453 T1270 oasc.SyncStrategy.syncToMe http://127.0.0.1:59023/solr/collection1/ has no replicas
[junit4:junit4]   2> 5453 T1270 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:59023/solr/collection1/
[junit4:junit4]   2> 5454 T1270 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4:junit4]   2> 5456 T1275 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139e93b0d940003 type:create cxid:0x4e zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5601 T1291 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 5622 T1290 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5623 T1304 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5657 T1270 oasc.ZkController.register We are http://127.0.0.1:59023/solr/collection1/ and leader is http://127.0.0.1:59023/solr/collection1/
[junit4:junit4]   2> 5658 T1270 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:59023/solr
[junit4:junit4]   2> 5658 T1270 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4]   2> 5660 T1270 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 5661 T1270 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1
[junit4:junit4]   2> 5661 T1270 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 5662 T1270 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 5712 T1270 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 5715 T1270 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:46058
[junit4:junit4]   2> 5715 T1270 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 5716 T1270 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-jetty2-1348237730735
[junit4:junit4]   2> 5716 T1270 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-jetty2-1348237730735/'
[junit4:junit4]   2> 5727 T1270 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 5728 T1270 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 5728 T1270 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-jetty2-1348237730735
[junit4:junit4]   2> 5728 T1270 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-jetty2-1348237730735/solr.xml
[junit4:junit4]   2> 5728 T1270 oasc.CoreContainer.<init> New CoreContainer 23843872
[junit4:junit4]   2> 5729 T1270 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-jetty2-1348237730735/'
[junit4:junit4]   2> 5729 T1270 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-jetty2-1348237730735/'
[junit4:junit4]   2> 5741 T1270 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 5749 T1270 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:50979/solr
[junit4:junit4]   2> 5750 T1270 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:50979/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@157c98
[junit4:junit4]   2> 5751 T1315 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:50979
[junit4:junit4]   2> 5751 T1270 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 5751 T1315 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:50979, initiating session
[junit4:junit4]   2> 5751 T1272 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:56991
[junit4:junit4]   2> 5751 T1272 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:56991
[junit4:junit4]   2> 5759 T1274 oazs.NIOServerCnxn.finishSessionInit Established session 0x139e93b0d940004 with negotiated timeout 5000 for client /127.0.0.1:56991
[junit4:junit4]   2> 5759 T1315 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:50979, sessionid = 0x139e93b0d940004, negotiated timeout = 5000
[junit4:junit4]   2> 5759 T1316 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@157c98 name:ZooKeeperConnection Watcher:127.0.0.1:50979/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 5759 T1270 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 5760 T1275 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139e93b0d940004 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5961 T1275 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139e93b0d940004 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5961 T1270 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:46058_solr
[junit4:junit4]   2> 5962 T1275 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139e93b0d940004 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:46058_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:46058_solr
[junit4:junit4]   2> 5963 T1270 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:46058_solr
[junit4:junit4]   2> 5964 T1290 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 5964 T1304 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 5964 T1270 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 5965 T1270 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 5965 T1270 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 5965 T1270 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 5966 T1270 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 5966 T1270 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 5966 T1270 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 5967 T1270 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 5967 T1270 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 5967 T1270 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 5980 T1270 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 5984 T1270 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-jetty2-1348237730735/collection1
[junit4:junit4]   2> 5984 T1270 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 5985 T1270 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 5985 T1270 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 5986 T1270 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-jetty2-1348237730735/collection1/'
[junit4:junit4]   2> 5987 T1270 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-jetty2-1348237730735/collection1/lib/README' to classloader
[junit4:junit4]   2> 5987 T1270 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-jetty2-1348237730735/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 6029 T1270 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_40
[junit4:junit4]   2> 6082 T1270 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 6082 T1270 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 6089 T1270 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 6125 T1291 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 6139 T1290 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 6139 T1316 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 6139 T1304 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 6513 T1270 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 6519 T1270 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 6522 T1270 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 6530 T1270 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 6533 T1270 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 6536 T1270 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 6537 T1270 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 6538 T1270 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-jetty2-1348237730735/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1348237725073/jetty2/
[junit4:junit4]   2> 6538 T1270 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@75f5b7
[junit4:junit4]   2> 6539 T1270 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1348237725073/jetty2/index/
[junit4:junit4]   2> 6539 T1270 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1348237725073/jetty2/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 6540 T1270 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-1348237725073/jetty2/index forceNew:false
[junit4:junit4]   2> 6930 T1270 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1348237725073/jetty2/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 6931 T1270 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 6932 T1270 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 6934 T1270 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 6934 T1270 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 6934 T1270 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 6935 T1270 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 6936 T1270 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 6936 T1270 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 6936 T1270 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 6937 T1270 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 6938 T1270 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 6938 T1270 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 6939 T1270 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 6939 T1270 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 6940 T1270 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 6940 T1270 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 6940 T1270 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 6941 T1270 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 6941 T1270 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6942 T1270 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6942 T1270 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6943 T1270 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6943 T1270 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6944 T1270 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6944 T1270 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6945 T1270 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 6945 T1270 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 6946 T1270 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 6948 T1270 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 6949 T1270 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> 6951 T1270 oass.SolrIndexSearcher.<init> Opening Searcher@2885a2 main
[junit4:junit4]   2> 6952 T1270 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 6952 T1270 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 6953 T1270 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 6978 T1270 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 7044 T1317 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2885a2 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 7142 T1291 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 7146 T1290 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 7146 T1316 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 7146 T1304 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 7551 T1270 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 7551 T1270 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:46058/solr shardId:shard1
[junit4:junit4]   2> 7569 T1270 oasc.ZkController.register We are http://127.0.0.1:46058/solr/collection1/ and leader is http://127.0.0.1:59023/solr/collection1/
[junit4:junit4]   2> 7570 T1270 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:46058/solr
[junit4:junit4]   2> 7570 T1270 oasc.ZkController.checkRecovery Core needs to recover:collection1
[junit4:junit4]   2> 7571 T1270 oasu.DefaultSolrCoreState.doRecovery Running recovery - first canceling any ongoing recovery
[junit4:junit4]   2> ASYNC  NEW_CORE C73 name=collection1 org.apache.solr.core.SolrCore@5796cf url=http://127.0.0.1:46058/solr/collection1 node=127.0.0.1:46058_solr
[junit4:junit4]   2> 7572 T1318 C73 P46058 oasc.RecoveryStrategy.run Starting recovery process.  core=collection1 recoveringAfterStartup=true
[junit4:junit4]   2> 7572 T1318 C73 P46058 oasc.RecoveryStrategy.doRecovery ###### startupVersions=[]
[junit4:junit4]   2> 7572 T1270 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 7573 T1318 C73 P46058 oasc.RecoveryStrategy.doRecovery Attempting to PeerSync from http://127.0.0.1:59023/solr/collection1/ core=collection1 - recoveringAfterStartup=true
[junit4:junit4]   2> 7573 T1318 C73 P46058 oasu.PeerSync.sync PeerSync: core=collection1 url=http://127.0.0.1:46058/solr START replicas=[http://127.0.0.1:59023/solr/collection1/] nUpdates=100
[junit4:junit4]   2> 7573 T1270 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1
[junit4:junit4]   2> 7573 T1318 C73 P46058 oasu.PeerSync.sync WARNING no frame of reference to tell of we've missed updates
[junit4:junit4]   2> 7573 T1270 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 7574 T1318 C73 P46058 oasc.RecoveryStrategy.doRecovery PeerSync Recovery was not successful - trying replication. core=collection1
[junit4:junit4]   2> 7574 T1318 C73 P46058 oasc.RecoveryStrategy.doRecovery Starting Replication Recovery. core=collection1
[junit4:junit4]   2> 7574 T1270 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 7574 T1318 C73 P46058 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 7577 T1270 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:50979/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@cb23b0
[junit4:junit4]   2> 7578 T1320 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:50979
[junit4:junit4]   2> 7578 T1270 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 7579 T1320 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:50979, initiating session
[junit4:junit4]   2> 7579 T1272 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:56995
[junit4:junit4]   2> 7579 T1272 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:56995
[junit4:junit4]   2> ASYNC  NEW_CORE C74 name=collection1 org.apache.solr.core.SolrCore@1060d1e url=http://127.0.0.1:59023/solr/collection1 node=127.0.0.1:59023_solr
[junit4:junit4]   2> 7579 T1296 C74 P59023 REQ /get {distrib=false&qt=/get&wt=javabin&version=2&getVersions=100} status=0 QTime=0 
[junit4:junit4]   2> 7580 T1274 oazs.NIOServerCnxn.finishSessionInit Established session 0x139e93b0d940005 with negotiated timeout 10000 for client /127.0.0.1:56995
[junit4:junit4]   2> 7581 T1320 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:50979, sessionid = 0x139e93b0d940005, negotiated timeout = 10000
[junit4:junit4]   2> 7581 T1321 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@cb23b0 name:ZooKeeperConnection Watcher:127.0.0.1:50979/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 7581 T1270 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 7581 T1270 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 7582 T1270 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:true cause connection loss:true
[junit4:junit4]   2> 7583 T1270 oascsi.HttpClientUtil.createClient Creating new http client, config:
[junit4:junit4]   2> 7585 T1270 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> ASYNC  NEW_CORE C75 name=collection1 org.apache.solr.core.SolrCore@e4c71e url=http://127.0.0.1:52213/solr/collection1 node=127.0.0.1:52213_solr
[junit4:junit4]   2> 7593 T1282 C75 P52213 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1348237725073/control/data/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 7593 T1282 C75 P52213 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 7595 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[1 (1413729728762740736)]} 0 4
[junit4:junit4]   2> 7595 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10001 (1413729728763789312)]} 0 3
[junit4:junit4]   2> 7596 T1322 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:50979/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@1e9487d
[junit4:junit4]   2> 7596 T1324 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:50979
[junit4:junit4]   2> 7596 T1322 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 7597 T1324 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:50979, initiating session
[junit4:junit4]   2> 7597 T1272 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:56998
[junit4:junit4]   2> 7597 T1272 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:56998
[junit4:junit4]   2> 7609 T1324 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:50979, sessionid = 0x139e93b0d940006, negotiated timeout = 10000
[junit4:junit4]   2> 7609 T1274 oazs.NIOServerCnxn.finishSessionInit Established session 0x139e93b0d940006 with negotiated timeout 10000 for client /127.0.0.1:56998
[junit4:junit4]   2> 7609 T1325 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1e9487d name:ZooKeeperConnection Watcher:127.0.0.1:50979/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 7609 T1322 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 7610 T1322 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 7615 T1299 C74 P59023 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1348237725073/jetty1/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 7615 T1299 C74 P59023 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 7618 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[1 (1413729728785809409)]} 0 5
[junit4:junit4]   2> 7618 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10001 (1413729728785809408)]} 0 5
[junit4:junit4]   2> 7620 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[2 (1413729728793149441)]} 0 0
[junit4:junit4]   2> 7620 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10002 (1413729728793149440)]} 0 0
[junit4:junit4]   2> 7622 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[2 (1413729728795246592)]} 0 0
[junit4:junit4]   2> 7623 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10002 (1413729728795246593)]} 0 1
[junit4:junit4]   2> 7625 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[2 (-1413729728797343744)]} 0 1
[junit4:junit4]   2> 7625 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10002 (-1413729728798392320)]} 0 1
[junit4:junit4]   2> 7628 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10002 (-1413729728800489473)]} 0 1
[junit4:junit4]   2> 7628 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[2 (-1413729728800489472)]} 0 1
[junit4:junit4]   2> 7630 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10003 (1413729728803635200)]} 0 1
[junit4:junit4]   2> 7630 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[3 (1413729728803635201)]} 0 0
[junit4:junit4]   2> 7632 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10003 (1413729728805732352)]} 0 0
[junit4:junit4]   2> 7632 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[3 (1413729728805732353)]} 0 0
[junit4:junit4]   2> 7635 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[10003 (-1413729728808878080)]} 0 1
[junit4:junit4]   2> 7635 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[3 (-1413729728808878081)]} 0 1
[junit4:junit4]   2> 7637 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10003 (-1413729728810975232)]} 0 0
[junit4:junit4]   2> 7637 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[3 (-1413729728810975233)]} 0 0
[junit4:junit4]   2> 7639 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[4 (1413729728813072384)]} 0 0
[junit4:junit4]   2> 7639 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10004 (1413729728813072385)]} 0 0
[junit4:junit4]   2> 7642 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[4 (1413729728815169536)]} 0 1
[junit4:junit4]   2> 7642 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10004 (1413729728815169537)]} 0 1
[junit4:junit4]   2> 7644 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[5 (1413729728818315264)]} 0 0
[junit4:junit4]   2> 7646 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[5 (1413729728820412416)]} 0 0
[junit4:junit4]   2> 7647 T1291 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 7649 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[6 (1413729728822509568)]} 0 1
[junit4:junit4]   2> 7650 T1304 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 7650 T1290 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 7650 T1316 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 7650 T1325 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 7650 T1321 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 7655 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10005 (1413729728818315265)]} 0 11
[junit4:junit4]   2>  C73_STATE=coll:collection1 core:collection1 props:{shard=shard1, roles=null, state=recovering, core=collection1, collection=collection1, node_name=127.0.0.1:46058_solr, base_url=http://127.0.0.1:46058/solr}
[junit4:junit4]   2> 7670 T1308 C73 P46058 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1348237725073/jetty2/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 7671 T1308 C73 P46058 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 7673 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=5 
[junit4:junit4]   2> 7673 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 7673 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10005 (1413729728840335360)]} 0 8
[junit4:junit4]   2> 7673 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[6 (1413729728831946752)]} 0 16
[junit4:junit4]   2> 7676 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[7 (1413729728850821121)]} 0 1
[junit4:junit4]   2> 7676 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10006 (1413729728850821120)]} 0 1
[junit4:junit4]   2> 7680 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7680 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7680 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[7 (1413729728852918272)]} 0 3
[junit4:junit4]   2> 7681 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10006 (1413729728853966848)]} 0 2
[junit4:junit4]   2> 7682 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[8 (1413729728858161152)]} 0 0
[junit4:junit4]   2> 7683 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10007 (1413729728858161153)]} 0 1
[junit4:junit4]   2> 7686 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7687 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7687 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[8 (1413729728860258304)]} 0 3
[junit4:junit4]   2> 7687 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10007 (1413729728860258305)]} 0 3
[junit4:junit4]   2> 7689 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[9 (1413729728865501184)]} 0 0
[junit4:junit4]   2> 7689 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10008 (1413729728865501185)]} 0 0
[junit4:junit4]   2> 7693 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7694 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7694 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10008 (1413729728867598337)]} 0 3
[junit4:junit4]   2> 7694 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[9 (1413729728867598336)]} 0 3
[junit4:junit4]   2> 7696 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10009 (1413729728871792640)]} 0 1
[junit4:junit4]   2> 7696 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10 (1413729728872841216)]} 0 0
[junit4:junit4]   2> 7702 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7703 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10009 (1413729728874938368)]} 0 6
[junit4:junit4]   2> 7722 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10010 (1413729728882278400)]} 0 17
[junit4:junit4]   2> 7724 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=17 
[junit4:junit4]   2> 7725 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10 (1413729728874938369)]} 0 27
[junit4:junit4]   2> 7728 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[11 (1413729728905347072)]} 0 2
[junit4:junit4]   2> 7734 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7734 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7734 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10010 (1413729728902201344)]} 0 10
[junit4:junit4]   2> 7734 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[11 (1413729728908492800)]} 0 4
[junit4:junit4]   2> 7736 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[7 (-1413729728914784257)]} 0 0
[junit4:junit4]   2> 7737 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10011 (1413729728914784256)]} 0 1
[junit4:junit4]   2> 7741 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7741 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[7 (-1413729728917929984)]} 0 3
[junit4:junit4]   2> 7742 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7742 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10011 (1413729728917929985)]} 0 4
[junit4:junit4]   2> 7743 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[12 (1413729728922124288)]} 0 0
[junit4:junit4]   2> 7744 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10007 (-1413729728923172864)]} 0 0
[junit4:junit4]   2> 7747 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7748 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7748 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[12 (1413729728924221440)]} 0 3
[junit4:junit4]   2> 7748 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10007 (-1413729728925270016)]} 0 2
[junit4:junit4]   2> 7750 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[8 (-1413729728929464320)]} 0 0
[junit4:junit4]   2> 7750 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10012 (1413729728929464321)]} 0 0
[junit4:junit4]   2> 7753 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7754 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[8 (-1413729728931561472)]} 0 2
[junit4:junit4]   2> 7754 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7755 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10012 (1413729728931561473)]} 0 3
[junit4:junit4]   2> 7756 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[13 (1413729728935755776)]} 0 0
[junit4:junit4]   2> 7757 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10008 (-1413729728936804352)]} 0 1
[junit4:junit4]   2> 7760 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7760 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7760 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10008 (-1413729728937852929)]} 0 2
[junit4:junit4]   2> 7760 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[13 (1413729728937852928)]} 0 2
[junit4:junit4]   2> 7762 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[9 (-1413729728942047233)]} 0 0
[junit4:junit4]   2> 7762 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10013 (1413729728942047232)]} 0 0
[junit4:junit4]   2> 7766 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7767 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[9 (-1413729728944144384)]} 0 3
[junit4:junit4]   2> 7767 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7767 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10013 (1413729728944144385)]} 0 3
[junit4:junit4]   2> 7769 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[14 (1413729728949387264)]} 0 1
[junit4:junit4]   2> 7769 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[10009 (-1413729728949387265)]} 0 0
[junit4:junit4]   2> 7773 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7774 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7774 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[10009 (-1413729728951484417)]} 0 3
[junit4:junit4]   2> 7774 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[14 (1413729728951484416)]} 0 3
[junit4:junit4]   2> 7776 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10014 (1413729728956727296)]} 0 0
[junit4:junit4]   2> 7777 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[15 (1413729728956727297)]} 0 0
[junit4:junit4]   2> 7781 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7781 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10014 (1413729728958824448)]} 0 3
[junit4:junit4]   2> 7791 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10015 (1413729728964067328)]} 0 8
[junit4:junit4]   2> 7792 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=12 
[junit4:junit4]   2> 7792 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[15 (1413729728958824449)]} 0 14
[junit4:junit4]   2> 7794 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10 (-1413729728975601664)]} 0 0
[junit4:junit4]   2> 7803 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=8 
[junit4:junit4]   2> 7803 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10015 (1413729728974553088)]} 0 10
[junit4:junit4]   2> 7804 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7805 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[10 (-1413729728983990272)]} 0 2
[junit4:junit4]   2> 7806 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10010 (-1413729728987136000)]} 0 1
[junit4:junit4]   2> 7807 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[16 (1413729728988184576)]} 0 1
[junit4:junit4]   2> 7809 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7810 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[10010 (-1413729728989233152)]} 0 3
[junit4:junit4]   2> 7811 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7812 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10016 (1413729728993427456)]} 0 1
[junit4:junit4]   2> 7812 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[16 (1413729728991330304)]} 0 3
[junit4:junit4]   2> 7814 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[17 (1413729728996573184)]} 0 0
[junit4:junit4]   2> 7816 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7816 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10016 (1413729728996573184)]} 0 2
[junit4:junit4]   2> 7818 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7818 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10017 (1413729729000767488)]} 0 0
[junit4:junit4]   2> 7819 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[17 (1413729728998670336)]} 0 3
[junit4:junit4]   2> 7821 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[18 (1413729729002864640)]} 0 1
[junit4:junit4]   2> 7822 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7823 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10017 (1413729729002864640)]} 0 3
[junit4:junit4]   2> 7825 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7825 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10018 (1413729729008107520)]} 0 0
[junit4:junit4]   2> 7826 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[18 (1413729729006010368)]} 0 4
[junit4:junit4]   2> 7828 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[19 (1413729729011253248)]} 0 1
[junit4:junit4]   2> 7829 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7830 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10018 (1413729729010204672)]} 0 3
[junit4:junit4]   2> 7832 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7832 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10019 (1413729729015447552)]} 0 0
[junit4:junit4]   2> 7833 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[19 (1413729729013350400)]} 0 3
[junit4:junit4]   2> 7835 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[20 (1413729729017544704)]} 0 1
[junit4:junit4]   2> 7839 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7839 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[20 (1413729729020690432)]} 0 2
[junit4:junit4]   2> 7841 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[11 (-1413729729024884736)]} 0 0
[junit4:junit4]   2> 7845 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7846 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[11 (-1413729729026981888)]} 0 3
[junit4:junit4]   2> 7854 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=11 
[junit4:junit4]   2> 7854 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10019 (1413729729017544704)]} 0 20
[junit4:junit4]   2> 7857 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10020 (1413729729040613376)]} 0 1
[junit4:junit4]   2> 7858 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[21 (1413729729032224768)]} 0 10
[junit4:junit4]   2> 7863 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7864 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10020 (1413729729043759104)]} 0 5
[junit4:junit4]   2> 7866 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[10011 (-1413729729051099136)]} 0 0
[junit4:junit4]   2> 7870 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7870 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[21 (1413729729044807680)]} 0 10
[junit4:junit4]   2> 7870 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7871 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10011 (-1413729729054244864)]} 0 3
[junit4:junit4]   2> 7872 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[22 (1413729729057390592)]} 0 0
[junit4:junit4]   2> 7873 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10021 (1413729729058439168)]} 0 1
[junit4:junit4]   2> 7877 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7878 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[22 (1413729729060536320)]} 0 3
[junit4:junit4]   2> 7878 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7878 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10021 (1413729729060536321)]} 0 3
[junit4:junit4]   2> 7881 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[13 (-1413729729066827776)]} 0 2
[junit4:junit4]   2> 7882 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10022 (1413729729066827777)]} 0 1
[junit4:junit4]   2> 7885 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7885 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[13 (-1413729729068924928)]} 0 2
[junit4:junit4]   2> 7886 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7886 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10022 (1413729729068924929)]} 0 3
[junit4:junit4]   2> 7887 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[23 (1413729729073119232)]} 0 0
[junit4:junit4]   2> 7888 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10013 (-1413729729074167808)]} 0 0
[junit4:junit4]   2> 7892 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7892 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7893 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[10013 (-1413729729076264960)]} 0 3
[junit4:junit4]   2> 7893 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[23 (1413729729075216384)]} 0 4
[junit4:junit4]   2> 7895 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[15 (-1413729729081507840)]} 0 1
[junit4:junit4]   2> 7895 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10023 (1413729729080459264)]} 0 1
[junit4:junit4]   2> 7898 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7899 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[15 (-1413729729083604993)]} 0 3
[junit4:junit4]   2> 7899 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7899 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10023 (1413729729083604992)]} 0 3
[junit4:junit4]   2> 7901 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[24 (1413729729086750720)]} 0 1
[junit4:junit4]   2> 7901 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[10015 (-1413729729087799296)]} 0 0
[junit4:junit4]   2> 7904 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7905 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10015 (-1413729729089896449)]} 0 2
[junit4:junit4]   2> 7905 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7905 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[24 (1413729729089896448)]} 0 3
[junit4:junit4]   2> 7907 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10024 (1413729729094090752)]} 0 1
[junit4:junit4]   2> 7907 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[25 (1413729729094090753)]} 0 0
[junit4:junit4]   2> 7911 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7912 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10024 (1413729729096187904)]} 0 3
[junit4:junit4]   2> 7918 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=7 
[junit4:junit4]   2> 7918 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[25 (1413729729096187905)]} 0 9
[junit4:junit4]   2> 7921 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[16 (-1413729729107722240)]} 0 1
[junit4:junit4]   2> 7922 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10025 (1413729729100382208)]} 0 9
[junit4:junit4]   2> 7924 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7925 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[16 (-1413729729110867968)]} 0 2
[junit4:junit4]   2> 7927 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7928 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10025 (1413729729111916544)]} 0 4
[junit4:junit4]   2> 7928 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[26 (1413729729115062272)]} 0 1
[junit4:junit4]   2> 7930 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[10016 (-1413729729118208000)]} 0 0
[junit4:junit4]   2> 7932 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7932 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[26 (1413729729118208000)]} 0 2
[junit4:junit4]   2> 7933 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7933 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10016 (-1413729729119256576)]} 0 2
[junit4:junit4]   2> 7934 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[22 (-1413729729122402304)]} 0 0
[junit4:junit4]   2> 7936 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10026 (1413729729123450880)]} 0 1
[junit4:junit4]   2> 7938 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7938 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[22 (-1413729729124499456)]} 0 2
[junit4:junit4]   2> 7940 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7940 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10026 (1413729729125548032)]} 0 3
[junit4:junit4]   2> 7940 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[27 (1413729729128693760)]} 0 0
[junit4:junit4]   2> 7942 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[10022 (-1413729729130790912)]} 0 0
[junit4:junit4]   2> 7944 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7945 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[27 (1413729729130790912)]} 0 3
[junit4:junit4]   2> 7946 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7946 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10022 (-1413729729132888064)]} 0 2
[junit4:junit4]   2> 7947 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[27 (-1413729729136033792)]} 0 0
[junit4:junit4]   2> 7948 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10027 (1413729729137082368)]} 0 0
[junit4:junit4]   2> 7951 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7951 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[27 (-1413729729138130944)]} 0 2
[junit4:junit4]   2> 7953 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7953 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10027 (1413729729139179520)]} 0 3
[junit4:junit4]   2> 7953 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[28 (1413729729142325248)]} 0 0
[junit4:junit4]   2> 7956 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[10027 (-1413729729144422400)]} 0 1
[junit4:junit4]   2> 7959 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7960 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10027 (-1413729729147568128)]} 0 2
[junit4:junit4]   2> 7963 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10028 (1413729729151762432)]} 0 1
[junit4:junit4]   2> 7965 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7966 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[28 (1413729729145470976)]} 0 11
[junit4:junit4]   2> 7967 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7967 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10028 (1413729729154908160)]} 0 3
[junit4:junit4]   2> 7968 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[28 (-1413729729158053888)]} 0 1
[junit4:junit4]   2> 7969 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10028 (-1413729729159102464)]} 0 0
[junit4:junit4]   2> 7971 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7972 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[28 (-1413729729160151040)]} 0 3
[junit4:junit4]   2> 7973 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7973 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[10028 (-1413729729161199616)]} 0 2
[junit4:junit4]   2> 7974 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[29 (1413729729164345344)]} 0 1
[junit4:junit4]   2> 7975 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10029 (1413729729165393920)]} 0 0
[junit4:junit4]   2> 7980 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7980 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7980 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10029 (1413729729167491072)]} 0 3
[junit4:junit4]   2> 7981 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[29 (1413729729166442496)]} 0 5
[junit4:junit4]   2> 7983 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[30 (1413729729173782528)]} 0 0
[junit4:junit4]   2> 7993 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10030 (1413729729173782529)]} 0 10
[junit4:junit4]   2> 7995 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=7 
[junit4:junit4]   2> 7995 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[30 (1413729729176928256)]} 0 9
[junit4:junit4]   2> 7997 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[30 (-1413729729188462592)]} 0 0
[junit4:junit4]   2> 7999 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8000 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10030 (1413729729187414016)]} 0 4
[junit4:junit4]   2> 8001 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8001 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[30 (-1413729729190559744)]} 0 2
[junit4:junit4]   2> 8002 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[10030 (-1413729729193705472)]} 0 0
[junit4:junit4]   2> 8005 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[31 (1413729729195802624)]} 0 2
[junit4:junit4]   2> 8006 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8006 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[10030 (-1413729729195802624)]} 0 2
[junit4:junit4]   2> 8009 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10031 (1413729729199996928)]} 0 1
[junit4:junit4]   2> 8009 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8010 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[31 (1413729729198948352)]} 0 3
[junit4:junit4]   2> 8012 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[32 (1413729729204191232)]} 0 1
[junit4:junit4]   2> 8013 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8013 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10031 (1413729729203142656)]} 0 2
[junit4:junit4]   2> 8016 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10032 (1413729729207336960)]} 0 1
[junit4:junit4]   2> 8021 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8021 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10032 (1413729729210482688)]} 0 3
[junit4:junit4]   2> 8023 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8023 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[32 (1413729729206288384)]} 0 9
[junit4:junit4]   2> 8024 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10033 (1413729729216774144)]} 0 1
[junit4:junit4]   2> 8026 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[33 (1413729729218871296)]} 0 1
[junit4:junit4]   2> 8029 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8029 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10033 (1413729729218871296)]} 0 3
[junit4:junit4]   2> 8030 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8031 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[33 (1413729729220968448)]} 0 3
[junit4:junit4]   2> 8032 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10034 (1413729729224114176)]} 0 1
[junit4:junit4]   2> 8033 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[34 (1413729729226211328)]} 0 0
[junit4:junit4]   2> 8036 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8037 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10034 (1413729729227259904)]} 0 3
[junit4:junit4]   2> 8037 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8038 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[34 (1413729729228308480)]} 0 3
[junit4:junit4]   2> 8039 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10033 (-1413729729232502784)]} 0 0
[junit4:junit4]   2> 8040 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[33 (-1413729729233551360)]} 0 0
[junit4:junit4]   2> 8044 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8044 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8044 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[33 (-1413729729235648513)]} 0 2
[junit4:junit4]   2> 8045 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10033 (-1413729729235648512)]} 0 2
[junit4:junit4]   2> 8047 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[35 (1413729729239842816)]} 0 1
[junit4:junit4]   2> 8058 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10035 (1413729729240891392)]} 0 12
[junit4:junit4]   2> 8059 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=8 
[junit4:junit4]   2> 8060 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[35 (1413729729242988544)]} 0 11
[junit4:junit4]   2> 8063 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[36 (1413729729256620032)]} 0 1
[junit4:junit4]   2> 8063 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8064 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10035 (1413729729255571456)]} 0 4
[junit4:junit4]   2> 8066 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10036 (1413729729260814336)]} 0 0
[junit4:junit4]   2> 8067 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8067 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[36 (1413729729259765760)]} 0 2
[junit4:junit4]   2> 8069 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[34 (-1413729729263960064)]} 0 0
[junit4:junit4]   2> 8070 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8070 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10036 (1413729729262911488)]} 0 2
[junit4:junit4]   2> 8072 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10034 (-1413729729267105792)]} 0 0
[junit4:junit4]   2> 8073 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8073 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[34 (-1413729729266057216)]} 0 2
[junit4:junit4]   2> 8075 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[37 (1413729729270251520)]} 0 0
[junit4:junit4]   2> 8076 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8076 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[10034 (-1413729729269202944)]} 0 2
[junit4:junit4]   2> 8079 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10037 (1413729729273397248)]} 0 1
[junit4:junit4]   2> 8080 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8080 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[37 (1413729729272348672)]} 0 3
[junit4:junit4]   2> 8083 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8083 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[38 (1413729729277591552)]} 0 1
[junit4:junit4]   2> 8083 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10037 (1413729729276542976)]} 0 2
[junit4:junit4]   2> 8086 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10038 (1413729729280737280)]} 0 1
[junit4:junit4]   2> 8087 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8088 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[38 (1413729729280737280)]} 0 3
[junit4:junit4]   2> 8090 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[39 (1413729729285980160)]} 0 0
[junit4:junit4]   2> 8095 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8096 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[39 (1413729729289125888)]} 0 4
[junit4:junit4]   2> 8098 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[35 (-1413729729294368768)]} 0 0
[junit4:junit4]   2> 8098 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8099 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10038 (1413729729282834432)]} 0 12
[junit4:junit4]   2> 8101 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10039 (1413729729297514496)]} 0 0
[junit4:junit4]   2> 8102 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8102 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[35 (-1413729729296465920)]} 0 2
[junit4:junit4]   2> 8105 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[40 (1413729729300660224)]} 0 1
[junit4:junit4]   2> 8106 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8106 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10039 (1413729729299611648)]} 0 3
[junit4:junit4]   2> 8108 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10035 (-1413729729304854528)]} 0 0
[junit4:junit4]   2> 8112 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8113 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[10035 (-1413729729308000256)]} 0 3
[junit4:junit4]   2> 8116 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=7 
[junit4:junit4]   2> 8117 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[40 (1413729729303805952)]} 0 10
[junit4:junit4]   2> 8121 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[41 (1413729729316388864)]} 0 2
[junit4:junit4]   2> 8127 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8128 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[41 (1413729729320583168)]} 0 5
[junit4:junit4]   2> 8131 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[42 (1413729729327923200)]} 0 1
[junit4:junit4]   2> 8170 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10040 (1413729729312194560)]} 0 55
[junit4:junit4]   2> 8175 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8175 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10040 (1413729729373011968)]} 0 3
[junit4:junit4]   2> 8178 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10041 (1413729729377206272)]} 0 1
[junit4:junit4]   2> 8183 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8183 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8183 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[42 (1413729729331068928)]} 0 50
[junit4:junit4]   2> 8184 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10041 (1413729729380352000)]} 0 4
[junit4:junit4]   2> 8186 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[43 (1413729729385594880)]} 0 1
[junit4:junit4]   2> 8186 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10042 (1413729729386643456)]} 0 1
[junit4:junit4]   2> 8190 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8191 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8191 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[43 (1413729729388740608)]} 0 3
[junit4:junit4]   2> 8191 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10042 (1413729729388740609)]} 0 3
[junit4:junit4]   2> 8194 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10043 (1413729729393983488)]} 0 1
[junit4:junit4]   2> 8194 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[44 (1413729729393983489)]} 0 1
[junit4:junit4]   2> 8199 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8199 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10043 (1413729729397129216)]} 0 3
[junit4:junit4]   2> 8202 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10044 (1413729729403420672)]} 0 1
[junit4:junit4]   2> 8204 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8204 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[44 (1413729729401323520)]} 0 4
[junit4:junit4]   2> 8207 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[45 (1413729729407614976)]} 0 1
[junit4:junit4]   2> 8208 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8208 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10044 (1413729729406566400)]} 0 3
[junit4:junit4]   2> 8217 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10045 (1413729729411809280)]} 0 7
[junit4:junit4]   2> 8222 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8222 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10045 (1413729729421246464)]} 0 3
[junit4:junit4]   2> 8224 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10038 (-1413729729426489344)]} 0 0
[junit4:junit4]   2> 8228 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8228 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10038 (-1413729729428586496)]} 0 2
[junit4:junit4]   2> 8231 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10046 (1413729729432780800)]} 0 1
[junit4:junit4]   2> 8236 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8236 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10046 (1413729729435926528)]} 0 3
[junit4:junit4]   2> 8238 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10039 (-1413729729441169408)]} 0 0
[junit4:junit4]   2> 8242 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8242 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10039 (-1413729729443266560)]} 0 2
[junit4:junit4]   2> 8244 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10047 (1413729729447460864)]} 0 0
[junit4:junit4]   2> 8249 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8249 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10047 (1413729729449558016)]} 0 3
[junit4:junit4]   2> 8252 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10040 (-1413729729454800896)]} 0 1
[junit4:junit4]   2> 8256 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8256 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10040 (-1413729729457946624)]} 0 2
[junit4:junit4]   2> 8259 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10048 (1413729729462140928)]} 0 1
[junit4:junit4]   2> 8263 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8264 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10048 (1413729729465286656)]} 0 3
[junit4:junit4]   2> 8266 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10041 (-1413729729470529536)]} 0 0
[junit4:junit4]   2> 8269 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8270 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10041 (-1413729729472626688)]} 0 2
[junit4:junit4]   2> 8271 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=61 
[junit4:junit4]   2> 8271 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[45 (1413729729409712128)]} 0 63
[junit4:junit4]   2> 8272 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10049 (1413729729476820992)]} 0 0
[junit4:junit4]   2> 8273 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[38 (-1413729729477869568)]} 0 0
[junit4:junit4]   2> 8277 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8277 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8277 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[38 (-1413729729479966720)]} 0 2
[junit4:junit4]   2> 8277 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10049 (1413729729478918144)]} 0 3
[junit4:junit4]   2> 8279 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[10045 (-1413729729484161024)]} 0 0
[junit4:junit4]   2> 8280 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[46 (1413729729485209600)]} 0 1
[junit4:junit4]   2> 8283 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8283 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10045 (-1413729729486258176)]} 0 2
[junit4:junit4]   2> 8284 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8285 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[46 (1413729729487306752)]} 0 3
[junit4:junit4]   2> 8285 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10050 (1413729729490452480)]} 0 0
[junit4:junit4]   2> 8287 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[39 (-1413729729492549632)]} 0 0
[junit4:junit4]   2> 8290 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8290 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10050 (1413729729492549632)]} 0 3
[junit4:junit4]   2> 8291 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8291 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[39 (-1413729729494646784)]} 0 2
[junit4:junit4]   2> 8292 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10051 (1413729729497792512)]} 0 0
[junit4:junit4]   2> 8294 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[47 (1413729729498841088)]} 0 1
[junit4:junit4]   2> 8296 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8297 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10051 (1413729729499889664)]} 0 3
[junit4:junit4]   2> 8299 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10052 (1413729729505132544)]} 0 0
[junit4:junit4]   2> 8304 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8305 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10052 (1413729729508278272)]} 0 4
[junit4:junit4]   2> 8318 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=12 
[junit4:junit4]   2> 8318 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10053 (1413729729513521152)]} 0 12
[junit4:junit4]   2> 8318 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[47 (1413729729501986816)]} 0 22
[junit4:junit4]   2> 8320 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[40 (-1413729729527152640)]} 0 0
[junit4:junit4]   2> 8324 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8325 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[40 (-1413729729529249792)]} 0 3
[junit4:junit4]   2> 8328 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[48 (1413729729534492672)]} 0 2
[junit4:junit4]   2> 8339 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=5 
[junit4:junit4]   2> 8339 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=5 
[junit4:junit4]   2> 8339 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10053 (1413729729527152640)]} 0 19
[junit4:junit4]   2> 8339 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[48 (1413729729537638400)]} 0 9
[junit4:junit4]   2> 8342 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[41 (-1413729729550221313)]} 0 1
[junit4:junit4]   2> 8342 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10046 (-1413729729550221312)]} 0 1
[junit4:junit4]   2> 8345 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8345 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8346 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[41 (-1413729729552318464)]} 0 2
[junit4:junit4]   2> 8346 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10046 (-1413729729552318465)]} 0 2
[junit4:junit4]   2> 8348 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[49 (1413729729556512768)]} 0 0
[junit4:junit4]   2> 8349 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10054 (1413729729556512769)]} 0 1
[junit4:junit4]   2> 8353 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8354 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10054 (1413729729559658496)]} 0 3
[junit4:junit4]   2> 8354 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8354 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[49 (1413729729558609920)]} 0 4
[junit4:junit4]   2> 8356 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[10048 (-1413729729563852800)]} 0 1
[junit4:junit4]   2> 8356 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[45 (-1413729729564901376)]} 0 0
[junit4:junit4]   2> 8359 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8360 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8360 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[45 (-1413729729566998529)]} 0 2
[junit4:junit4]   2> 8363 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[50 (1413729729572241408)]} 0 0
[junit4:junit4]   2> 8364 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10048 (-1413729729566998528)]} 0 7
[junit4:junit4]   2> 8367 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10055 (1413729729576435712)]} 0 0
[junit4:junit4]   2> 8368 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8369 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[50 (1413729729575387136)]} 0 3
[junit4:junit4]   2> 8372 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[51 (1413729729580630016)]} 0 1
[junit4:junit4]   2> 8373 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8373 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10055 (1413729729579581440)]} 0 3
[junit4:junit4]   2> 8376 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10056 (1413729729584824320)]} 0 1
[junit4:junit4]   2> 8376 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8377 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[51 (1413729729583775744)]} 0 3
[junit4:junit4]   2> 8379 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[52 (1413729729589018624)]} 0 0
[junit4:junit4]   2> 8380 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8381 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10056 (1413729729587970048)]} 0 3
[junit4:junit4]   2> 8384 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8384 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[52 (1413729729591115776)]} 0 3
[junit4:junit4]   2> 8385 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10049 (-1413729729595310080)]} 0 1
[junit4:junit4]   2> 8387 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[53 (1413729729596358656)]} 0 1
[junit4:junit4]   2> 8388 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8389 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[10049 (-1413729729597407232)]} 0 3
[junit4:junit4]   2> 8399 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10057 (1413729729601601536)]} 0 8
[junit4:junit4]   2> 8401 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=10 
[junit4:junit4]   2> 8402 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[53 (1413729729598455808)]} 0 14
[junit4:junit4]   2> 8404 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[46 (-1413729729615233024)]} 0 0
[junit4:junit4]   2> 8405 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8405 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10057 (1413729729613135872)]} 0 3
[junit4:junit4]   2> 8407 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[10050 (-1413729729618378752)]} 0 0
[junit4:junit4]   2> 8408 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8408 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[46 (-1413729729617330176)]} 0 2
[junit4:junit4]   2> 8411 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8411 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[10050 (-1413729729620475904)]} 0 2
[junit4:junit4]   2> 8411 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[54 (1413729729621524480)]} 0 1
[junit4:junit4]   2> 8414 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10058 (1413729729625718784)]} 0 1
[junit4:junit4]   2> 8416 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8416 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[54 (1413729729625718784)]} 0 2
[junit4:junit4]   2> 8418 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[48 (-1413729729629913088)]} 0 0
[junit4:junit4]   2> 8419 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8419 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10058 (1413729729627815936)]} 0 3
[junit4:junit4]   2> 8421 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10059 (1413729729633058816)]} 0 0
[junit4:junit4]   2> 8422 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8422 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[48 (-1413729729632010240)]} 0 2
[junit4:junit4]   2> 8425 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[55 (1413729729636204544)]} 0 1
[junit4:junit4]   2> 8426 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8426 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10059 (1413729729635155968)]} 0 3
[junit4:junit4]   2> 8428 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10060 (1413729729640398848)]} 0 0
[junit4:junit4]   2> 8429 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8429 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[55 (1413729729638301696)]} 0 3
[junit4:junit4]   2> 8431 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[56 (1413729729643544576)]} 0 0
[junit4:junit4]   2> 8433 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8433 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10060 (1413729729642496000)]} 0 3
[junit4:junit4]   2> 8435 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10052 (-1413729729647738880)]} 0 0
[junit4:junit4]   2> 8436 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8436 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[56 (1413729729645641728)]} 0 3
[junit4:junit4]   2> 8438 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[49 (-1413729729650884608)]} 0 0
[junit4:junit4]   2> 8439 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8439 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10052 (-1413729729649836032)]} 0 2
[junit4:junit4]   2> 8441 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8442 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10061 (1413729729654030336)]} 0 1
[junit4:junit4]   2> 8442 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[49 (-1413729729652981760)]} 0 2
[junit4:junit4]   2> 8444 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[57 (1413729729657176064)]} 0 0
[junit4:junit4]   2> 8446 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8447 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10061 (1413729729657176064)]} 0 3
[junit4:junit4]   2> 8449 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10062 (1413729729662418944)]} 0 0
[junit4:junit4]   2> 8454 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8455 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10062 (1413729729665564672)]} 0 4
[junit4:junit4]   2> 8463 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=9 
[junit4:junit4]   2> 8464 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[57 (1413729729659273216)]} 0 18
[junit4:junit4]   2> 8466 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10063 (1413729729670807552)]} 0 9
[junit4:junit4]   2> 8467 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[50 (-1413729729680244736)]} 0 1
[junit4:junit4]   2> 8470 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8471 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[50 (-1413729729683390464)]} 0 2
[junit4:junit4]   2> 8472 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8473 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10063 (1413729729682341888)]} 0 5
[junit4:junit4]   2> 8474 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[58 (1413729729687584768)]} 0 1
[junit4:junit4]   2> 8475 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10064 (1413729729689681920)]} 0 0
[junit4:junit4]   2> 8478 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8478 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[58 (1413729729690730496)]} 0 3
[junit4:junit4]   2> 8481 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[59 (1413729729694924800)]} 0 1
[junit4:junit4]   2> 8485 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8486 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[59 (1413729729698070528)]} 0 3
[junit4:junit4]   2> 8488 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[60 (1413729729703313408)]} 0 0
[junit4:junit4]   2> 8489 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8490 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10064 (1413729729691779072)]} 0 13
[junit4:junit4]   2> 8492 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10065 (1413729729706459136)]} 0 1
[junit4:junit4]   2> 8493 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8493 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[60 (1413729729705410560)]} 0 3
[junit4:junit4]   2> 8495 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[52 (-1413729729710653440)]} 0 0
[junit4:junit4]   2> 8497 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8498 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10065 (1413729729709604864)]} 0 4
[junit4:junit4]   2> 8499 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8499 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[52 (-1413729729712750592)]} 0 2
[junit4:junit4]   2> 8500 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10055 (-1413729729715896320)]} 0 1
[junit4:junit4]   2> 8501 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[61 (1413729729716944896)]} 0 0
[junit4:junit4]   2> 8503 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8504 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[10055 (-1413729729716944896)]} 0 3
[junit4:junit4]   2> 8506 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8506 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10066 (1413729729721139200)]} 0 1
[junit4:junit4]   2> 8506 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[61 (1413729729719042048)]} 0 3
[junit4:junit4]   2> 8508 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[62 (1413729729724284928)]} 0 0
[junit4:junit4]   2> 8510 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8511 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10066 (1413729729724284928)]} 0 3
[junit4:junit4]   2> 8513 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[10056 (-1413729729728479232)]} 0 1
[junit4:junit4]   2> 8513 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8513 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[62 (1413729729726382080)]} 0 3
[junit4:junit4]   2> 8516 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[63 (1413729729731624960)]} 0 1
[junit4:junit4]   2> 8516 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8517 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[10056 (-1413729729731624960)]} 0 2
[junit4:junit4]   2> 8527 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10067 (1413729729734770688)]} 0 9
[junit4:junit4]   2> 8529 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=10 
[junit4:junit4]   2> 8530 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[63 (1413729729734770688)]} 0 13
[junit4:junit4]   2> 8533 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8533 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[64 (1413729729749450752)]} 0 1
[junit4:junit4]   2> 8533 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10067 (1413729729747353600)]} 0 4
[junit4:junit4]   2> 8536 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10068 (1413729729753645056)]} 0 0
[junit4:junit4]   2> 8538 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8539 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[64 (1413729729753645056)]} 0 4
[junit4:junit4]   2> 8540 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8541 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[65 (1413729729758887936)]} 0 0
[junit4:junit4]   2> 8541 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10068 (1413729729755742208)]} 0 3
[junit4:junit4]   2> 8543 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[10057 (-1413729729760985088)]} 0 0
[junit4:junit4]   2> 8545 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8546 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[65 (1413729729760985088)]} 0 3
[junit4:junit4]   2> 8547 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8547 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[10057 (-1413729729763082240)]} 0 2
[junit4:junit4]   2> 8548 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[55 (-1413729729766227968)]} 0 0
[junit4:junit4]   2> 8549 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10069 (1413729729767276544)]} 0 0
[junit4:junit4]   2> 8551 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8552 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[55 (-1413729729768325120)]} 0 2
[junit4:junit4]   2> 8553 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8554 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10069 (1413729729769373696)]} 0 3
[junit4:junit4]   2> 8554 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[66 (1413729729772519424)]} 0 0
[junit4:junit4]   2> 8556 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[10059 (-1413729729774616576)]} 0 0
[junit4:junit4]   2> 8559 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8559 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[66 (1413729729774616576)]} 0 3
[junit4:junit4]   2> 8559 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8560 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[10059 (-1413729729776713728)]} 0 2
[junit4:junit4]   2> 8561 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[56 (-1413729729779859456)]} 0 0
[junit4:junit4]   2> 8562 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10070 (1413729729780908032)]} 0 1
[junit4:junit4]   2> 8565 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8565 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[56 (-1413729729781956608)]} 0 2
[junit4:junit4]   2> 8566 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8567 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10070 (1413729729783005184)]} 0 3
[junit4:junit4]   2> 8568 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[67 (1413729729786150912)]} 0 1
[junit4:junit4]   2> 8569 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[10061 (-1413729729788248064)]} 0 0
[junit4:junit4]   2> 8572 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8573 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[10061 (-1413729729790345216)]} 0 2
[junit4:junit4]   2> 8575 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10071 (1413729729794539520)]} 0 0
[junit4:junit4]   2> 8580 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8580 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8580 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10071 (1413729729796636672)]} 0 3
[junit4:junit4]   2> 8580 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[67 (1413729729789296640)]} 0 11
[junit4:junit4]   2> 8583 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[68 (1413729729802928128)]} 0 1
[junit4:junit4]   2> 8584 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[10062 (-1413729729803976704)]} 0 0
[junit4:junit4]   2> 8587 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8588 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[10062 (-1413729729806073856)]} 0 2
[junit4:junit4]   2> 8597 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10072 (1413729729810268160)]} 0 7
[junit4:junit4]   2> 8598 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=10 
[junit4:junit4]   2> 8598 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[68 (1413729729805025280)]} 0 13
[junit4:junit4]   2> 8600 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[57 (-1413729729820753920)]} 0 0
[junit4:junit4]   2> 8602 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8603 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10072 (1413729729819705344)]} 0 4
[junit4:junit4]   2> 8603 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8604 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[57 (-1413729729822851072)]} 0 2
[junit4:junit4]   2> 8605 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[10064 (-1413729729824948224)]} 0 1
[junit4:junit4]   2> 8607 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[69 (1413729729827045376)]} 0 1
[junit4:junit4]   2> 8608 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8608 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10064 (-1413729729827045376)]} 0 2
[junit4:junit4]   2> 8611 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10073 (1413729729831239680)]} 0 1
[junit4:junit4]   2> 8615 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8615 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10073 (1413729729833336832)]} 0 3
[junit4:junit4]   2> 8618 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10074 (1413729729838579712)]} 0 1
[junit4:junit4]   2> 8618 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8618 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[69 (1413729729830191104)]} 0 9
[junit4:junit4]   2> 8620 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[59 (-1413729729841725440)]} 0 0
[junit4:junit4]   2> 8622 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8622 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10074 (1413729729841725440)]} 0 3
[junit4:junit4]   2> 8623 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8624 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[59 (-1413729729843822592)]} 0 2
[junit4:junit4]   2> 8624 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10068 (-1413729729845919744)]} 0 0
[junit4:junit4]   2> 8626 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[70 (1413729729848016896)]} 0 0
[junit4:junit4]   2> 8628 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8628 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[10068 (-1413729729848016896)]} 0 2
[junit4:junit4]   2> 8631 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8631 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10075 (1413729729852211200)]} 0 1
[junit4:junit4]   2> 8631 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[70 (1413729729850114048)]} 0 3
[junit4:junit4]   2> 8633 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[61 (-1413729729855356928)]} 0 0
[junit4:junit4]   2> 8636 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8636 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10075 (1413729729855356928)]} 0 3
[junit4:junit4]   2> 8637 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8637 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[61 (-1413729729857454080)]} 0 2
[junit4:junit4]   2> 8638 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[10071 (-1413729729860599808)]} 0 0
[junit4:junit4]   2> 8639 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[71 (1413729729861648384)]} 0 0
[junit4:junit4]   2> 8641 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8642 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10071 (-1413729729862696960)]} 0 2
[junit4:junit4]   2> 8643 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8644 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[71 (1413729729863745536)]} 0 3
[junit4:junit4]   2> 8644 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10076 (1413729729866891264)]} 0 0
[junit4:junit4]   2> 8645 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[62 (-1413729729867939840)]} 0 0
[junit4:junit4]   2> 8648 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8648 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10076 (1413729729868988416)]} 0 2
[junit4:junit4]   2> 8649 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8649 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[62 (-1413729729870036992)]} 0 2
[junit4:junit4]   2> 8650 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10077 (1413729729873182720)]} 0 0
[junit4:junit4]   2> 8652 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[72 (1413729729874231296)]} 0 1
[junit4:junit4]   2> 8655 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8655 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10077 (1413729729875279872)]} 0 3
[junit4:junit4]   2> 8657 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10076 (-1413729729880522752)]} 0 0
[junit4:junit4]   2> 8661 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8661 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10076 (-1413729729882619904)]} 0 2
[junit4:junit4]   2> 8661 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=6 
[junit4:junit4]   2> 8662 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[72 (1413729729876328448)]} 0 9
[junit4:junit4]   2> 8664 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[64 (-1413729729887862784)]} 0 0
[junit4:junit4]   2> 8667 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8668 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[64 (-1413729729889959936)]} 0 2
[junit4:junit4]   2> 8671 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[73 (1413729729894154240)]} 0 1
[junit4:junit4]   2> 8677 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8678 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[73 (1413729729897299968)]} 0 5
[junit4:junit4]   2> 8680 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[74 (1413729729904640000)]} 0 1
[junit4:junit4]   2> 8685 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8685 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[74 (1413729729906737152)]} 0 3
[junit4:junit4]   2> 8687 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[68 (-1413729729911980032)]} 0 0
[junit4:junit4]   2> 8691 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8692 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[68 (-1413729729914077184)]} 0 3
[junit4:junit4]   2> 8694 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[75 (1413729729918271488)]} 0 1
[junit4:junit4]   2> 8698 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8699 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[75 (1413729729921417216)]} 0 4
[junit4:junit4]   2> 8701 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10078 (1413729729886814208)]} 0 38
[junit4:junit4]   2> 8701 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[71 (-1413729729926660096)]} 0 1
[junit4:junit4]   2> 8705 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8706 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[71 (-1413729729928757248)]} 0 3
[junit4:junit4]   2> 8706 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8707 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10078 (1413729729928757249)]} 0 4
[junit4:junit4]   2> 8709 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[76 (1413729729934000128)]} 0 1
[junit4:junit4]   2> 8709 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10079 (1413729729935048704)]} 0 0
[junit4:junit4]   2> 8713 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8714 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8714 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[76 (1413729729937145856)]} 0 4
[junit4:junit4]   2> 8714 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10079 (1413729729937145857)]} 0 3
[junit4:junit4]   2> 8716 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[77 (1413729729942388736)]} 0 0
[junit4:junit4]   2> 8720 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10080 (1413729729946583040)]} 0 0
[junit4:junit4]   2> 8721 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8722 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[77 (1413729729945534464)]} 0 4
[junit4:junit4]   2> 8724 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[76 (-1413729729950777344)]} 0 0
[junit4:junit4]   2> 8725 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8725 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10080 (1413729729948680192)]} 0 3
[junit4:junit4]   2> 8728 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10081 (1413729729953923072)]} 0 1
[junit4:junit4]   2> 8728 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8729 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[76 (-1413729729952874496)]} 0 3
[junit4:junit4]   2> 8731 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[78 (1413729729958117376)]} 0 1
[junit4:junit4]   2> 8733 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8733 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10081 (1413729729957068800)]} 0 3
[junit4:junit4]   2> 8747 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10082 (1413729729963360256)]} 0 12
[junit4:junit4]   2> 8793 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8793 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10082 (1413729729978040320)]} 0 43
[junit4:junit4]   2> 8796 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10083 (1413729730025226240)]} 0 1
[junit4:junit4]   2> 8802 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8802 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10083 (1413729730028371968)]} 0 4
[junit4:junit4]   2> 8805 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10084 (1413729730034663424)]} 0 1
[junit4:junit4]   2> 8809 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8810 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10084 (1413729730037809152)]} 0 4
[junit4:junit4]   2> 8812 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10084 (-1413729730043052032)]} 0 0
[junit4:junit4]   2> 8816 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8817 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10084 (-1413729730045149184)]} 0 3
[junit4:junit4]   2> 8819 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10085 (1413729730050392064)]} 0 0
[junit4:junit4]   2> 8824 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8824 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10085 (1413729730052489216)]} 0 3
[junit4:junit4]   2> 8826 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10085 (-1413729730057732096)]} 0 0
[junit4:junit4]   2> 8830 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8831 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10085 (-1413729730059829248)]} 0 3
[junit4:junit4]   2> 8833 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10086 (1413729730064023552)]} 0 1
[junit4:junit4]   2> 8837 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8837 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10086 (1413729730067169280)]} 0 3
[junit4:junit4]   2> 8839 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10086 (-1413729730071363584)]} 0 0
[junit4:junit4]   2> 8843 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8843 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10086 (-1413729730073460736)]} 0 2
[junit4:junit4]   2> 8845 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=55 
[junit4:junit4]   2> 8845 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[78 (1413729729960214528)]} 0 112
[junit4:junit4]   2> 8846 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10087 (1413729730077655040)]} 0 1
[junit4:junit4]   2> 8848 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[79 (1413729730079752192)]} 0 1
[junit4:junit4]   2> 8851 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8852 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10087 (1413729730080800768)]} 0 4
[junit4:junit4]   2> 8852 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8853 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[79 (1413729730082897920)]} 0 3
[junit4:junit4]   2> 8854 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10088 (1413729730087092224)]} 0 0
[junit4:junit4]   2> 8855 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[80 (1413729730088140800)]} 0 0
[junit4:junit4]   2> 8858 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8859 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10088 (1413729730089189376)]} 0 3
[junit4:junit4]   2> 8859 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8859 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[80 (1413729730090237952)]} 0 2
[junit4:junit4]   2> 8861 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10089 (1413729730094432256)]} 0 0
[junit4:junit4]   2> 8870 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[81 (1413729730094432257)]} 0 8
[junit4:junit4]   2> 8874 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=9 
[junit4:junit4]   2> 8874 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10089 (1413729730096529408)]} 0 11
[junit4:junit4]   2> 8875 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8876 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[81 (1413729730105966592)]} 0 4
[junit4:junit4]   2> 8877 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10090 (1413729730110160896)]} 0 1
[junit4:junit4]   2> 8878 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[82 (1413729730112258048)]} 0 0
[junit4:junit4]   2> 8881 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8882 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10090 (1413729730113306624)]} 0 3
[junit4:junit4]   2> 8882 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8883 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[82 (1413729730114355200)]} 0 3
[junit4:junit4]   2> 8884 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10091 (1413729730118549504)]} 0 0
[junit4:junit4]   2> 8885 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[83 (1413729730119598080)]} 0 1
[junit4:junit4]   2> 8888 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8889 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10091 (1413729730120646656)]} 0 3
[junit4:junit4]   2> 8889 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8889 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[83 (1413729730121695232)]} 0 2
[junit4:junit4]   2> 8891 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[10089 (-1413729730125889536)]} 0 1
[junit4:junit4]   2> 8892 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[84 (1413729730125889537)]} 0 1
[junit4:junit4]   2> 9100 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 9101 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10089 (-1413729730342944768)]} 0 3
[junit4:junit4]   2> 9101 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 9102 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[84 (1413729730342944769)]} 0 4
[junit4:junit4]   2> 9103 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10092 (1413729730348187648)]} 0 0
[junit4:junit4]   2> 9104 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[84 (-1413729730349236224)]} 0 0
[junit4:junit4]   2> 9108 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 9109 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 9110 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[84 (-1413729730351333376)]} 0 4
[junit4:junit4]   2> 9110 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10092 (1413729730350284800)]} 0 5
[junit4:junit4]   2> 9112 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[85 (1413729730357624832)]} 0 1
[junit4:junit4]   2> 9112 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10090 (-1413729730357624833)]} 0 0
[junit4:junit4]   2> 9117 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 9118 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 9118 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[85 (1413729730359721985)]} 0 4
[junit4:junit4]   2> 9118 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10090 (-1413729730359721984)]} 0 4
[junit4:junit4]   2> 9120 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[85 (-1413729730366013440)]} 0 0
[junit4:junit4]   2> 9121 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10093 (1413729730366013441)]} 0 1
[junit4:junit4]   2> 9124 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 9125 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[85 (-1413729730368110592)]} 0 3
[junit4:junit4]   2> 9126 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 9126 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10093 (1413729730368110593)]} 0 4
[junit4:junit4]   2> 9127 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[86 (1413729730372304896)]} 0 1
[junit4:junit4]   2> 9139 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10094 (1413729730374402048)]} 0 11
[junit4:junit4]   2> 9144 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=8 
[junit4:junit4]   2> 9145 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[86 (1413729730375450624)]} 0 17
[junit4:junit4]   2> 9147 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[86 (-1413729730394324992)]} 0 0
[junit4:junit4]   2> 9150 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 9151 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[86 (-1413729730396422144)]} 0 2
[junit4:junit4]   2> 9154 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[87 (1413729730400616448)]} 0 1
[junit4:junit4]   2> 9159 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 9160 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 9160 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[87 (1413729730403762176)]} 0 4
[junit4:junit4]   2> 9160 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10094 (1413729730388033536)]} 0 19
[junit4:junit4]   2> 9162 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[88 (1413729730410053632)]} 0 0
[junit4:junit4]   2> 9162 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[10091 (-1413729730410053633)]} 0 0
[junit4:junit4]   2> 9166 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 9166 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[10091 (-1413729730412150784)]} 0 2
[junit4:junit4]   2> 9167 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 9168 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[88 (1413729730412150785)]} 0 4
[junit4:junit4]   2> 9170 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10095 (1413729730417393664)]} 0 1
[junit4:junit4]   2> 9170 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[89 (1413729730418442240)]} 0 0
[junit4:junit4]   2> 9174 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 9174 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10095 (1413729730420539392)]} 0 3
[junit4:junit4]   2> 9174 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 9175 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[89 (1413729730420539393)]} 0 3
[junit4:junit4]   2> 9177 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[10092 (-1413729730424733696)]} 0 1
[junit4:junit4]   2> 9177 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[90 (1413729730425782272)]} 0 1
[junit4:junit4]   2> 9180 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 9181 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[10092 (-1413729730427879424)]} 0 2
[junit4:junit4]   2> 9181 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 9181 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[90 (1413729730427879425)]} 0 2
[junit4:junit4]   2> 9183 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10096 (1413729730432073728)]} 0 0
[junit4:junit4]   2> 9184 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[91 (1413729730432073729)]} 0 1
[junit4:junit4]   2> 9187 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 9187 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10096 (1413729730434170880)]} 0 2
[junit4:junit4]   2> 9188 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 9188 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[91 (1413729730434170881)]} 0 3
[junit4:junit4]   2> 9189 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10097 (1413729730438365184)]} 0 0
[junit4:junit4]   2> 9190 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[89 (-1413729730439413760)]} 0 0
[junit4:junit4]   2> 9193 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 9193 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 9194 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10097 (1413729730440462336)]} 0 3
[junit4:junit4]   2> 9194 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[89 (-1413729730441510912)]} 0 2
[junit4:junit4]   2> 9196 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[10098 (1413729730445705216)]} 0 1
[junit4:junit4]   2> 9206 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[92 (1413729730445705217)]} 0 10
[junit4:junit4]   2> 9208 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=9 
[junit4:junit4]   2> 9208 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10098 (1413729730447802368)]} 0 11
[junit4:junit4]   2> 9211 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10099 (1413729730460385280)]} 0 1
[junit4:junit4]   2> 9211 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 9212 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[92 (1413729730459336704)]} 0 4
[junit4:junit4]   2> 9214 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[90 (-1413729730463531008)]} 0 1
[junit4:junit4]   2> 9215 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 9216 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[10099 (1413729730463531008)]} 0 3
[junit4:junit4]   2> 9217 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 9217 T1299 C74 P59023 /update {wt=javabin&version=2} {delete=[90 (-1413729730466676736)]} 0 2
[junit4:junit4]   2> 9218 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10100 (1413729730467725312)]} 0 1
[junit4:junit4]   2> 9220 T1283 C75 P52213 /update {wt=javabin&version=2} {add=[93 (1413729730469822464)]} 0 1
[junit4:junit4]   2> 9222 T1309 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 9222 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[10100 (1413729730470871040)]} 0 2
[junit4:junit4]   2> 9224 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 9224 T1298 C74 P59023 /update {wt=javabin&version=2} {add=[93 (1413729730471919616)]} 0 3
[junit4:junit4]   2> 9224 T1283 C75 P52213 /update {wt=javabin&version=2} {delete=[10094 (-1413729730475065344)]} 0 0
[junit4:junit4]   2> 9226 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[94 (1413729730477162496)]} 0 0
[junit4:junit4]   2> 9228 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 9228 T1298 C74 P59023 /update {wt=javabin&version=2} {delete=[10094 (-1413729730477162496)]} 0 2
[junit4:junit4]   2> 9230 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 9230 T1282 C75 P52213 /update {wt=javabin&version=2} {add=[10101 (1413729730481356800)]} 0 0
[junit4:junit4]   2> 9231 T1299 C74 P59023 /update {wt=javabin&version=2} {add=[94 (1413729730479259648)]} 0 3
[junit4:junit4]   2> 9233 T1282 C75 P52213 /update {wt=javabin&version=2} {delete=[91 (-1413729730483453952)]} 0 1
[junit4:junit4]   2> 9235 T1308 C73 P46058 REQ /update {distrib.from=http://127.0.0.1:59023/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 9235 T1298 C74 P59023 /update {wt=ja

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

$SendThread.run(ClientCnxn.java:1143)
[junit4:junit4]   2> 
[junit4:junit4]   2> 28951 T1303 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost.localdomain/127.0.0.1:50979
[junit4:junit4]   2> 29051 T1304 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 29051 T1270 oaz.ZooKeeper.close Session: 0x139e93b0d940003 closed
[junit4:junit4]   2> 29052 T1270 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 29103 T1270 oasc.ChaosMonkey.monkeyLog monkey: stop shard! 46058
[junit4:junit4]   2> 29103 T1270 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=10613116
[junit4:junit4]   2> 30166 T1433 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost.localdomain/127.0.0.1:50979
[junit4:junit4]   2> 30267 T1434 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 30267 T1270 oaz.ZooKeeper.close Session: 0x139e93b0d940007 closed
[junit4:junit4]   2> 30267 T1270 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 30355 T1270 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=RecoveryZkTest -Dtests.method=testDistribSearch -Dtests.seed=9403B5413D1D5215 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=nl -Dtests.timezone=Australia/Queensland -Dtests.file.encoding=US-ASCII
[junit4:junit4] ERROR   30.4s J1 | RecoveryZkTest.testDistribSearch <<<
[junit4:junit4]    > Throwable #1: org.apache.solr.common.SolrException: Server at http://127.0.0.1:46058/solr/collection1 returned non ok status:404, message:Can not find: /solr/collection1/select
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([9403B5413D1D5215:15E53B594A423229]:0)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:373)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:182)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:90)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:324)
[junit4:junit4]    > 	at org.apache.solr.cloud.RecoveryZkTest.doTest(RecoveryZkTest.java:92)
[junit4:junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:695)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
[junit4:junit4]    > 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
[junit4:junit4]    > 	at java.lang.reflect.Method.invoke(Method.java:597)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at java.lang.Thread.run(Thread.java:662)
[junit4:junit4]   2> 30398 T1270 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4]   2> NOTE: test params are: codec=Lucene40: {range_facet_l=PostingsFormat(name=MockRandom), text=MockFixedIntBlock(blockSize=396), _version_=PostingsFormat(name=MockRandom), rnd_b=PostingsFormat(name=Asserting), intDefault=PostingsFormat(name=MockRandom), id=PostingsFormat(name=Asserting), timestamp=PostingsFormat(name=MockRandom), a_t=PostingsFormat(name=MockRandom), range_facet_sl=MockFixedIntBlock(blockSize=396), range_facet_si=PostingsFormat(name=SimpleText), other_tl1=PostingsFormat(name=MockRandom), multiDefault=PostingsFormat(name=SimpleText), a_si=PostingsFormat(name=SimpleText)}, sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {}, locale=nl, timezone=Australia/Queensland
[junit4:junit4]   2> NOTE: Linux 3.2.0-30-generic i386/Sun Microsystems Inc. 1.6.0_35 (32-bit)/cpus=8,threads=1,free=109956296,total=260898816
[junit4:junit4]   2> NOTE: All tests run in this JVM: [TestDistributedSearch, RAMDirectoryFactoryTest, TestRealTimeGet, TestSolrDeletionPolicy1, OverseerTest, TestDocSet, URLClassifyProcessorTest, DocumentBuilderTest, HighlighterTest, TestCodecSupport, PrimitiveFieldTypeTest, DebugComponentTest, XsltUpdateRequestHandlerTest, TestRTGBase, TestRecovery, TestPropInjectDefaults, QueryParsingTest, DisMaxRequestHandlerTest, SyncSliceTest, DistributedQueryElevationComponentTest, FieldMutatingUpdateProcessorTest, BasicFunctionalityTest, TestSolrXMLSerializer, TestHashPartitioner, BasicZkTest, DirectUpdateHandlerTest, TestMultiCoreConfBootstrap, TestMergePolicyConfig, TestSort, TestArbitraryIndexDir, LukeRequestHandlerTest, IndexReaderFactoryTest, SuggesterTSTTest, TestReplicationHandler, RecoveryZkTest]
[junit4:junit4] Completed on J1 in 30.42s, 1 test, 1 error <<< FAILURES!

[...truncated 427 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:32: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:179: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/module-build.xml:63: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1140: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:813: There were test failures: 231 suites, 954 tests, 1 error, 7 ignored (2 assumptions)

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



Mime
View raw message