lucene-dev mailing list archives

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

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

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




Build Log:
[...truncated 8653 lines...]
[junit4:junit4] Suite: org.apache.solr.cloud.RecoveryZkTest
[junit4:junit4]   2> 3 T1398 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4:junit4]   2> Creating dataDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./solrtest-RecoveryZkTest-1350727682557
[junit4:junit4]   2> 4 T1398 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4]   2> 7 T1399 oazs.ZooKeeperServer.setTickTime tickTime set to 1000
[junit4:junit4]   2> 7 T1399 oazs.NIOServerCnxn$Factory.<init> binding to port 0.0.0.0/0.0.0.0:0
[junit4:junit4]   2> 8 T1399 oazsp.FileTxnSnapLog.save Snapshotting: 0
[junit4:junit4]   2> 106 T1398 oasc.ZkTestServer.run start zk server on port:55806
[junit4:junit4]   2> 106 T1398 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:55806 sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@614e6f5d
[junit4:junit4]   2> 107 T1404 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:55806
[junit4:junit4]   2> 107 T1398 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 108 T1404 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost/127.0.0.1:55806, initiating session
[junit4:junit4]   2> 108 T1400 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /140.211.11.196:55807
[junit4:junit4]   2> 108 T1400 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /140.211.11.196:55807
[junit4:junit4]   2> 109 T1402 oazsp.FileTxnLog.append Creating new log file: log.1
[junit4:junit4]   2> 112 T1402 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a7da4ca010000 with negotiated timeout 10000 for client /140.211.11.196:55807
[junit4:junit4]   2> 112 T1404 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost/127.0.0.1:55806, sessionid = 0x13a7da4ca010000, negotiated timeout = 10000
[junit4:junit4]   2> 112 T1405 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@614e6f5d name:ZooKeeperConnection Watcher:127.0.0.1:55806 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 112 T1398 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 113 T1398 oascc.SolrZkClient.makePath makePath: /solr
[junit4:junit4]   2> 152 T1403 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13a7da4ca010000
[junit4:junit4]   2> 152 T1405 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 152 T1398 oaz.ZooKeeper.close Session: 0x13a7da4ca010000 closed
[junit4:junit4]   2> 153 T1400 oazs.NIOServerCnxn.closeSock Closed socket connection for client /140.211.11.196:55807 which had sessionid 0x13a7da4ca010000
[junit4:junit4]   2> 153 T1398 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:55806/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@7f95213b
[junit4:junit4]   2> 154 T1406 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:55806
[junit4:junit4]   2> 154 T1398 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 155 T1406 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost/127.0.0.1:55806, initiating session
[junit4:junit4]   2> 155 T1400 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /140.211.11.196:55808
[junit4:junit4]   2> 155 T1400 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /140.211.11.196:55808
[junit4:junit4]   2> 186 T1402 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a7da4ca010001 with negotiated timeout 10000 for client /140.211.11.196:55808
[junit4:junit4]   2> 186 T1406 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost/127.0.0.1:55806, sessionid = 0x13a7da4ca010001, negotiated timeout = 10000
[junit4:junit4]   2> 186 T1407 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@7f95213b name:ZooKeeperConnection Watcher:127.0.0.1:55806/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 187 T1398 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 187 T1398 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4:junit4]   2> 240 T1398 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4:junit4]   2> 242 T1398 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4:junit4]   2> 244 T1398 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4:junit4]   2> 254 T1398 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 255 T1398 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 267 T1398 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4:junit4]   2> 268 T1398 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4:junit4]   2> 373 T1398 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 374 T1398 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 376 T1398 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4:junit4]   2> 376 T1398 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
[junit4:junit4]   2> 390 T1398 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4:junit4]   2> 391 T1398 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
[junit4:junit4]   2> 393 T1398 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4:junit4]   2> 393 T1398 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
[junit4:junit4]   2> 395 T1398 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 396 T1398 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 405 T1398 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 406 T1398 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 407 T1398 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 408 T1398 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 414 T1398 oasc.AbstractZkTestCase.putConfig put /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4:junit4]   2> 415 T1398 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
[junit4:junit4]   2> 417 T1403 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13a7da4ca010001
[junit4:junit4]   2> 418 T1407 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 418 T1398 oaz.ZooKeeper.close Session: 0x13a7da4ca010001 closed
[junit4:junit4]   2> 418 T1400 oazs.NIOServerCnxn.closeSock Closed socket connection for client /140.211.11.196:55808 which had sessionid 0x13a7da4ca010001
[junit4:junit4]   2> 526 T1398 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 531 T1398 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:55809
[junit4:junit4]   2> 532 T1398 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 532 T1398 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1350727682971
[junit4:junit4]   2> 532 T1398 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1350727682971/'
[junit4:junit4]   2> 560 T1398 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 561 T1398 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 561 T1398 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1350727682971
[junit4:junit4]   2> 562 T1398 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1350727682971/solr.xml
[junit4:junit4]   2> 562 T1398 oasc.CoreContainer.<init> New CoreContainer 807415299
[junit4:junit4]   2> 562 T1398 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1350727682971/'
[junit4:junit4]   2> 563 T1398 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1350727682971/'
[junit4:junit4]   2> 585 T1398 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 596 T1398 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:55806/solr
[junit4:junit4]   2> 600 T1398 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:55806/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@188f7621
[junit4:junit4]   2> 601 T1417 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:55806
[junit4:junit4]   2> 601 T1398 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 602 T1417 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost/127.0.0.1:55806, initiating session
[junit4:junit4]   2> 602 T1400 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /140.211.11.196:55810
[junit4:junit4]   2> 602 T1400 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /140.211.11.196:55810
[junit4:junit4]   2> 609 T1402 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a7da4ca010002 with negotiated timeout 5000 for client /140.211.11.196:55810
[junit4:junit4]   2> 609 T1417 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost/127.0.0.1:55806, sessionid = 0x13a7da4ca010002, negotiated timeout = 5000
[junit4:junit4]   2> 609 T1418 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@188f7621 name:ZooKeeperConnection Watcher:127.0.0.1:55806/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 609 T1398 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 617 T1403 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a7da4ca010002 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 618 T1398 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4:junit4]   2> 632 T1398 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:55809_solr
[junit4:junit4]   2> 632 T1403 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a7da4ca010002 type:delete cxid:0x7 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:55809_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:55809_solr
[junit4:junit4]   2> 633 T1398 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:55809_solr
[junit4:junit4]   2> 635 T1398 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 635 T1398 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 636 T1398 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 636 T1398 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 636 T1398 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 637 T1398 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 637 T1398 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 637 T1398 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 638 T1398 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 638 T1398 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 649 T1398 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4:junit4]   2> 661 T1403 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a7da4ca010002 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> 662 T1398 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4]   2> 669 T1398 oasc.Overseer.start Overseer (id=88521289404317698-127.0.0.1:55809_solr-n_0000000000) starting
[junit4:junit4]   2> 669 T1403 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a7da4ca010002 type:create cxid:0x1a zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 670 T1403 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a7da4ca010002 type:create cxid:0x1b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 677 T1403 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a7da4ca010002 type:create cxid:0x1c zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 679 T1403 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a7da4ca010002 type:create cxid:0x1d zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 680 T1420 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
[junit4:junit4]   2> 680 T1398 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4:junit4]   2> 690 T1398 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 691 T1419 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4]   2> 698 T1398 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1350727682971/collection1
[junit4:junit4]   2> 698 T1398 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection
[junit4:junit4]   2> 699 T1398 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 699 T1398 oasc.ZkController.readConfigName Load collection config from:/collections/control_collection
[junit4:junit4]   2> 700 T1398 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1350727682971/collection1/'
[junit4:junit4]   2> 701 T1398 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-controljetty-1350727682971/collection1/lib/README' to classloader
[junit4:junit4]   2> 702 T1398 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-controljetty-1350727682971/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 738 T1398 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 785 T1398 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 886 T1398 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 891 T1398 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 1325 T1398 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 1332 T1398 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 1335 T1398 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 1344 T1398 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 1347 T1398 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 1351 T1398 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 1351 T1398 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 1352 T1398 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1350727682971/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1350727682557/control/data/
[junit4:junit4]   2> 1353 T1398 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@67010def
[junit4:junit4]   2> 1377 T1398 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1350727682557/control/data/index/
[junit4:junit4]   2> 1377 T1398 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1350727682557/control/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 1379 T1398 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-1350727682557/control/data/index forceNew:false
[junit4:junit4]   2> 1388 T1398 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1350727682557/control/data/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 1389 T1398 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 1389 T1398 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 1391 T1398 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 1392 T1398 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 1392 T1398 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 1392 T1398 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 1393 T1398 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 1393 T1398 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 1394 T1398 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 1394 T1398 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 1395 T1398 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 1395 T1398 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 1396 T1398 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 1396 T1398 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 1397 T1398 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 1397 T1398 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 1397 T1398 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 1398 T1398 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 1398 T1398 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1399 T1398 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1399 T1398 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1400 T1398 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1400 T1398 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1401 T1398 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1401 T1398 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1402 T1398 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 1402 T1398 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 1411 T1398 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 1414 T1398 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 1415 T1398 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> 1418 T1398 oass.SolrIndexSearcher.<init> Opening Searcher@27635a26 main
[junit4:junit4]   2> 1419 T1398 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 1420 T1398 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 1420 T1398 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 1426 T1398 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 1470 T1421 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@27635a26 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 1473 T1403 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a7da4ca010002 type:create cxid:0x53 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer/queue Error:KeeperErrorCode = NoNode for /solr/overseer/queue
[junit4:junit4]   2> 1475 T1398 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 1476 T1398 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:55809/solr shardId:control_shard
[junit4:junit4]   2> 1484 T1398 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=10000&maxConnectionsPerHost=20&connTimeout=30000&socketTimeout=30000&retry=false
[junit4:junit4]   2> 1495 T1398 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/control_shard/election
[junit4:junit4]   2> 1499 T1403 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a7da4ca010002 type:delete cxid:0x62 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/collections/control_collection/leaders Error:KeeperErrorCode = NoNode for /solr/collections/control_collection/leaders
[junit4:junit4]   2> 1500 T1398 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 1500 T1403 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a7da4ca010002 type:create cxid:0x63 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1696 T1419 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 1696 T1403 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a7da4ca010002 type:create cxid:0x6a zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer/queue-work Error:KeeperErrorCode = NoNode for /solr/overseer/queue-work
[junit4:junit4]   2> 1712 T1418 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 2003 T1398 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4]   2> 2004 T1398 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 2004 T1398 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:55809/solr/collection1/
[junit4:junit4]   2> 2005 T1398 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4:junit4]   2> 2005 T1398 oasc.SyncStrategy.syncToMe http://127.0.0.1:55809/solr/collection1/ has no replicas
[junit4:junit4]   2> 2006 T1398 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:55809/solr/collection1/
[junit4:junit4]   2> 2006 T1398 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/control_shard
[junit4:junit4]   2> 2009 T1403 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a7da4ca010002 type:create cxid:0x88 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2216 T1419 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2228 T1418 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 2275 T1398 oasc.ZkController.register We are http://127.0.0.1:55809/solr/collection1/ and leader is http://127.0.0.1:55809/solr/collection1/
[junit4:junit4]   2> 2275 T1398 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:55809/solr
[junit4:junit4]   2> 2276 T1398 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4]   2> 2277 T1398 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2278 T1398 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1
[junit4:junit4]   2> 2278 T1398 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 2278 T1398 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 2390 T1398 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 2393 T1398 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:55812
[junit4:junit4]   2> 2393 T1398 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 2394 T1398 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1350727684838
[junit4:junit4]   2> 2394 T1398 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1350727684838/'
[junit4:junit4]   2> 2422 T1398 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 2423 T1398 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 2423 T1398 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1350727684838
[junit4:junit4]   2> 2423 T1398 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1350727684838/solr.xml
[junit4:junit4]   2> 2424 T1398 oasc.CoreContainer.<init> New CoreContainer 1684487800
[junit4:junit4]   2> 2424 T1398 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1350727684838/'
[junit4:junit4]   2> 2424 T1398 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1350727684838/'
[junit4:junit4]   2> 2446 T1398 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 2457 T1398 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:55806/solr
[junit4:junit4]   2> 2458 T1398 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:55806/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@2a551eb1
[junit4:junit4]   2> 2459 T1431 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:55806
[junit4:junit4]   2> 2459 T1398 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 2460 T1431 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost/127.0.0.1:55806, initiating session
[junit4:junit4]   2> 2460 T1400 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /140.211.11.196:55813
[junit4:junit4]   2> 2460 T1400 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /140.211.11.196:55813
[junit4:junit4]   2> 2462 T1402 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a7da4ca010003 with negotiated timeout 5000 for client /140.211.11.196:55813
[junit4:junit4]   2> 2462 T1431 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost/127.0.0.1:55806, sessionid = 0x13a7da4ca010003, negotiated timeout = 5000
[junit4:junit4]   2> 2462 T1432 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@2a551eb1 name:ZooKeeperConnection Watcher:127.0.0.1:55806/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 2463 T1398 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 2463 T1403 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a7da4ca010003 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2476 T1403 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a7da4ca010003 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2477 T1398 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:55812_solr
[junit4:junit4]   2> 2478 T1403 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a7da4ca010003 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:55812_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:55812_solr
[junit4:junit4]   2> 2484 T1398 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:55812_solr
[junit4:junit4]   2> 2485 T1418 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 2486 T1398 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 2486 T1398 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 2486 T1398 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 2486 T1398 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 2487 T1398 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 2487 T1398 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 2487 T1398 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 2488 T1398 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 2488 T1398 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 2488 T1398 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 2499 T1398 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 2504 T1398 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1350727684838/collection1
[junit4:junit4]   2> 2504 T1398 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 2505 T1398 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 2505 T1398 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 2506 T1398 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1350727684838/collection1/'
[junit4:junit4]   2> 2507 T1398 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-jetty1-1350727684838/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 2507 T1398 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-jetty1-1350727684838/collection1/lib/README' to classloader
[junit4:junit4]   2> 2543 T1398 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 2591 T1398 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 2691 T1398 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 2696 T1398 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 2731 T1419 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2755 T1432 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 2755 T1418 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3118 T1398 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 3125 T1398 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 3128 T1398 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 3136 T1398 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 3140 T1398 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 3143 T1398 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 3144 T1398 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 3144 T1398 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1350727684838/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1350727682557/jetty1/
[junit4:junit4]   2> 3145 T1398 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@67010def
[junit4:junit4]   2> 3146 T1398 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1350727682557/jetty1/index/
[junit4:junit4]   2> 3146 T1398 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1350727682557/jetty1/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 3147 T1398 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-1350727682557/jetty1/index forceNew:false
[junit4:junit4]   2> 3152 T1398 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1350727682557/jetty1/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 3152 T1398 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 3153 T1398 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 3155 T1398 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 3155 T1398 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 3156 T1398 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 3156 T1398 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 3157 T1398 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 3157 T1398 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 3157 T1398 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 3158 T1398 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 3158 T1398 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 3159 T1398 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 3160 T1398 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 3160 T1398 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 3161 T1398 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 3161 T1398 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 3161 T1398 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 3162 T1398 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 3162 T1398 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3163 T1398 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3163 T1398 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3164 T1398 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3164 T1398 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3165 T1398 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3165 T1398 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3166 T1398 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 3166 T1398 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 3175 T1398 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 3179 T1398 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 3180 T1398 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> 3183 T1398 oass.SolrIndexSearcher.<init> Opening Searcher@91383df main
[junit4:junit4]   2> 3184 T1398 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 3184 T1398 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 3185 T1398 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 3190 T1398 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 3238 T1433 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@91383df main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 3258 T1419 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3271 T1432 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3271 T1418 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3745 T1398 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 3745 T1398 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:55812/solr shardId:shard1
[junit4:junit4]   2> 3746 T1398 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election
[junit4:junit4]   2> 3761 T1403 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a7da4ca010003 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> 3761 T1398 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 3762 T1403 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a7da4ca010003 type:create cxid:0x44 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3764 T1398 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4]   2> 3764 T1398 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 3765 T1398 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:55812/solr/collection1/
[junit4:junit4]   2> 3765 T1398 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4:junit4]   2> 3765 T1398 oasc.SyncStrategy.syncToMe http://127.0.0.1:55812/solr/collection1/ has no replicas
[junit4:junit4]   2> 3766 T1398 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:55812/solr/collection1/
[junit4:junit4]   2> 3766 T1398 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4:junit4]   2> 3778 T1403 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a7da4ca010003 type:create cxid:0x4e zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3779 T1419 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3804 T1432 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3804 T1418 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3837 T1398 oasc.ZkController.register We are http://127.0.0.1:55812/solr/collection1/ and leader is http://127.0.0.1:55812/solr/collection1/
[junit4:junit4]   2> 3837 T1398 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:55812/solr
[junit4:junit4]   2> 3838 T1398 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4]   2> 3839 T1398 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3840 T1398 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1
[junit4:junit4]   2> 3840 T1398 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 3840 T1398 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 3954 T1398 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 3957 T1398 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:55815
[junit4:junit4]   2> 3957 T1398 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 3957 T1398 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1350727686403
[junit4:junit4]   2> 3958 T1398 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1350727686403/'
[junit4:junit4]   2> 3985 T1398 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 3986 T1398 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 3986 T1398 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1350727686403
[junit4:junit4]   2> 3986 T1398 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1350727686403/solr.xml
[junit4:junit4]   2> 3987 T1398 oasc.CoreContainer.<init> New CoreContainer 741413045
[junit4:junit4]   2> 3987 T1398 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1350727686403/'
[junit4:junit4]   2> 3988 T1398 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1350727686403/'
[junit4:junit4]   2> 4010 T1398 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 4021 T1398 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:55806/solr
[junit4:junit4]   2> 4022 T1398 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:55806/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@238c0d9c
[junit4:junit4]   2> 4022 T1443 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:55806
[junit4:junit4]   2> 4022 T1398 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 4024 T1443 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost/127.0.0.1:55806, initiating session
[junit4:junit4]   2> 4024 T1400 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /140.211.11.196:55816
[junit4:junit4]   2> 4024 T1400 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /140.211.11.196:55816
[junit4:junit4]   2> 4026 T1402 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a7da4ca010004 with negotiated timeout 5000 for client /140.211.11.196:55816
[junit4:junit4]   2> 4026 T1443 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost/127.0.0.1:55806, sessionid = 0x13a7da4ca010004, negotiated timeout = 5000
[junit4:junit4]   2> 4026 T1444 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@238c0d9c name:ZooKeeperConnection Watcher:127.0.0.1:55806/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 4026 T1398 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 4027 T1403 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a7da4ca010004 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4036 T1403 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a7da4ca010004 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4037 T1398 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:55815_solr
[junit4:junit4]   2> 4038 T1403 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a7da4ca010004 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:55815_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:55815_solr
[junit4:junit4]   2> 4039 T1398 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:55815_solr
[junit4:junit4]   2> 4048 T1432 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 4048 T1418 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 4049 T1398 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 4049 T1398 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 4050 T1398 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 4050 T1398 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 4050 T1398 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 4050 T1398 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 4051 T1398 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 4051 T1398 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 4051 T1398 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 4052 T1398 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 4063 T1398 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 4068 T1398 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1350727686403/collection1
[junit4:junit4]   2> 4068 T1398 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 4069 T1398 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 4069 T1398 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 4070 T1398 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1350727686403/collection1/'
[junit4:junit4]   2> 4071 T1398 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-jetty2-1350727686403/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 4071 T1398 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-jetty2-1350727686403/collection1/lib/README' to classloader
[junit4:junit4]   2> 4107 T1398 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 4154 T1398 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 4255 T1398 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 4260 T1398 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 4325 T1419 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 4372 T1444 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4372 T1418 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4372 T1432 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4685 T1398 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 4693 T1398 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 4696 T1398 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 4703 T1398 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 4707 T1398 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 4710 T1398 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 4711 T1398 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 4711 T1398 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1350727686403/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1350727682557/jetty2/
[junit4:junit4]   2> 4712 T1398 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@67010def
[junit4:junit4]   2> 4713 T1398 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1350727682557/jetty2/index/
[junit4:junit4]   2> 4713 T1398 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1350727682557/jetty2/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 4714 T1398 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-1350727682557/jetty2/index forceNew:false
[junit4:junit4]   2> 4723 T1398 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1350727682557/jetty2/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 4724 T1398 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 4724 T1398 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 4726 T1398 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 4727 T1398 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 4727 T1398 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 4727 T1398 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 4728 T1398 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 4728 T1398 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 4729 T1398 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 4729 T1398 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 4730 T1398 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 4731 T1398 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 4731 T1398 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 4732 T1398 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 4732 T1398 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 4732 T1398 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 4733 T1398 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 4733 T1398 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 4734 T1398 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4734 T1398 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4735 T1398 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4735 T1398 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4736 T1398 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4736 T1398 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4737 T1398 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4738 T1398 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 4738 T1398 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 4749 T1398 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 4752 T1398 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 4753 T1398 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> 4756 T1398 oass.SolrIndexSearcher.<init> Opening Searcher@51745848 main
[junit4:junit4]   2> 4757 T1398 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 4757 T1398 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 4758 T1398 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 4764 T1398 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 4813 T1445 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@51745848 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 4876 T1419 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 4887 T1444 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4887 T1418 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4887 T1432 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5319 T1398 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 5319 T1398 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:55815/solr shardId:shard1
[junit4:junit4]   2> 5322 T1398 oasc.ZkController.register We are http://127.0.0.1:55815/solr/collection1/ and leader is http://127.0.0.1:55812/solr/collection1/
[junit4:junit4]   2> 5322 T1398 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:55815/solr
[junit4:junit4]   2> 5322 T1398 oasc.ZkController.checkRecovery Core needs to recover:collection1
[junit4:junit4]   2> 5323 T1398 oasu.DefaultSolrCoreState.doRecovery Running recovery - first canceling any ongoing recovery
[junit4:junit4]   2> ASYNC  NEW_CORE C72 name=collection1 org.apache.solr.core.SolrCore@623d87ee url=http://127.0.0.1:55815/solr/collection1 node=127.0.0.1:55815_solr
[junit4:junit4]   2> 5328 T1446 C72 P55815 oasc.RecoveryStrategy.run Starting recovery process.  core=collection1 recoveringAfterStartup=true
[junit4:junit4]   2> 5328 T1398 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 5329 T1446 C72 P55815 oasc.RecoveryStrategy.doRecovery ###### startupVersions=[]
[junit4:junit4]   2> 5330 T1398 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1
[junit4:junit4]   2> 5330 T1398 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 5330 T1446 C72 P55815 oasc.RecoveryStrategy.doRecovery Attempting to PeerSync from http://127.0.0.1:55812/solr/collection1/ core=collection1 - recoveringAfterStartup=true
[junit4:junit4]   2> 5330 T1398 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 5337 T1446 C72 P55815 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&connTimeout=30000&socketTimeout=30000&retry=false
[junit4:junit4]   2> 5344 T1398 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:55806/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@237d2cbc
[junit4:junit4]   2> 5345 T1447 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:55806
[junit4:junit4]   2> 5345 T1398 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 5346 T1447 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost/127.0.0.1:55806, initiating session
[junit4:junit4]   2> 5346 T1400 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /140.211.11.196:55820
[junit4:junit4]   2> 5346 T1400 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /140.211.11.196:55820
[junit4:junit4]   2> 5347 T1402 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a7da4ca010005 with negotiated timeout 10000 for client /140.211.11.196:55820
[junit4:junit4]   2> 5347 T1447 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost/127.0.0.1:55806, sessionid = 0x13a7da4ca010005, negotiated timeout = 10000
[junit4:junit4]   2> 5348 T1448 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@237d2cbc name:ZooKeeperConnection Watcher:127.0.0.1:55806/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 5348 T1398 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 5348 T1398 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 5349 T1446 C72 P55815 oasu.PeerSync.sync PeerSync: core=collection1 url=http://127.0.0.1:55815/solr START replicas=[http://127.0.0.1:55812/solr/collection1/] nUpdates=100
[junit4:junit4]   2> 5349 T1446 C72 P55815 oasu.PeerSync.sync WARNING no frame of reference to tell of we've missed updates
[junit4:junit4]   2> 5350 T1446 C72 P55815 oasc.RecoveryStrategy.doRecovery PeerSync Recovery was not successful - trying replication. core=collection1
[junit4:junit4]   2> 5351 T1446 C72 P55815 oasc.RecoveryStrategy.doRecovery Starting Replication Recovery. core=collection1
[junit4:junit4]   2> 5350 T1398 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:true cause connection loss:true
[junit4:junit4]   2> 5351 T1446 C72 P55815 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 5351 T1398 oascsi.HttpClientUtil.createClient Creating new http client, config:
[junit4:junit4]   2> ASYNC  NEW_CORE C73 name=collection1 org.apache.solr.core.SolrCore@5eb2870d url=http://127.0.0.1:55812/solr/collection1 node=127.0.0.1:55812_solr
[junit4:junit4]   2> 5358 T1424 C73 P55812 REQ /get {distrib=false&qt=/get&wt=javabin&version=2&getVersions=100} status=0 QTime=1 
[junit4:junit4]   2> 5360 T1398 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> ASYNC  NEW_CORE C74 name=collection1 org.apache.solr.core.SolrCore@38eb541c url=http://127.0.0.1:55809/solr/collection1 node=127.0.0.1:55809_solr
[junit4:junit4]   2> 5378 T1411 C74 P55809 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=500&maxConnectionsPerHost=16
[junit4:junit4]   2> 5390 T1419 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 5390 T1411 C74 P55809 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1350727682557/control/data/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 5391 T1411 C74 P55809 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 5395 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10001 (1416340636109373440)]} 0 26
[junit4:junit4]   2> 5395 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[1 (1416340636109373441)]} 0 26
[junit4:junit4]   2> 5396 T1450 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:55806/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@74fad37e
[junit4:junit4]   2> 5396 T1452 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:55806
[junit4:junit4]   2> 5396 T1450 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 5397 T1452 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost/127.0.0.1:55806, initiating session
[junit4:junit4]   2> 5397 T1400 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /140.211.11.196:55825
[junit4:junit4]   2> 5397 T1400 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /140.211.11.196:55825
[junit4:junit4]   2> 5402 T1444 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5402 T1418 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5402 T1448 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5402 T1432 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5403 T1402 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a7da4ca010006 with negotiated timeout 10000 for client /140.211.11.196:55825
[junit4:junit4]   2> 5403 T1452 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost/127.0.0.1:55806, sessionid = 0x13a7da4ca010006, negotiated timeout = 10000
[junit4:junit4]   2> 5403 T1453 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@74fad37e name:ZooKeeperConnection Watcher:127.0.0.1:55806/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 5404 T1450 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 5404 T1450 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 5439 T1426 C73 P55812 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1350727682557/jetty1/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 5440 T1426 C73 P55812 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2>  C72_STATE=coll:collection1 core:collection1 props:{shard=shard1, roles=null, state=recovering, core=collection1, collection=collection1, node_name=127.0.0.1:55815_solr, base_url=http://127.0.0.1:55815/solr}
[junit4:junit4]   2> 5472 T1436 C72 P55815 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1350727682557/jetty2/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 5472 T1436 C72 P55815 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 5475 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=7 
[junit4:junit4]   2> 5476 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 5476 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[1 (1416340636159705088)]} 0 68
[junit4:junit4]   2> 5476 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10001 (1416340636159705089)]} 0 68
[junit4:junit4]   2> 5480 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[10001 (-1416340636205842432)]} 0 1
[junit4:junit4]   2> 5480 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[1 (-1416340636205842433)]} 0 1
[junit4:junit4]   2> 5487 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5488 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5488 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[1 (-1416340636208988161)]} 0 6
[junit4:junit4]   2> 5488 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[10001 (-1416340636208988160)]} 0 6
[junit4:junit4]   2> 5490 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10002 (1416340636217376768)]} 0 0
[junit4:junit4]   2> 5491 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[2 (1416340636217376769)]} 0 1
[junit4:junit4]   2> 5497 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5497 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[2 (1416340636220522496)]} 0 4
[junit4:junit4]   2> 5497 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5498 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10002 (1416340636220522497)]} 0 5
[junit4:junit4]   2> 5499 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[2 (-1416340636226813952)]} 0 0
[junit4:junit4]   2> 5500 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[10002 (-1416340636227862528)]} 0 0
[junit4:junit4]   2> 5504 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5505 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[2 (-1416340636229959680)]} 0 3
[junit4:junit4]   2> 5505 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5506 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[10002 (-1416340636231008256)]} 0 3
[junit4:junit4]   2> 5508 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[3 (1416340636235202560)]} 0 1
[junit4:junit4]   2> 5508 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10003 (1416340636236251136)]} 0 0
[junit4:junit4]   2> 5513 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5514 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5514 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10003 (1416340636239396864)]} 0 3
[junit4:junit4]   2> 5515 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[3 (1416340636238348288)]} 0 5
[junit4:junit4]   2> 5516 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10004 (1416340636244639744)]} 0 0
[junit4:junit4]   2> 5517 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[4 (1416340636245688320)]} 0 0
[junit4:junit4]   2> 5521 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5522 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10004 (1416340636247785472)]} 0 3
[junit4:junit4]   2> 5523 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5524 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[4 (1416340636248834048)]} 0 4
[junit4:junit4]   2> 5524 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[10004 (-1416340636253028352)]} 0 0
[junit4:junit4]   2> 5527 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[4 (-1416340636256174080)]} 0 0
[junit4:junit4]   2> 5530 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5531 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[10004 (-1416340636256174080)]} 0 4
[junit4:junit4]   2> 5532 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5533 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[4 (-1416340636259319808)]} 0 3
[junit4:junit4]   2> 5533 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10005 (1416340636262465536)]} 0 0
[junit4:junit4]   2> 5535 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[5 (1416340636264562688)]} 0 0
[junit4:junit4]   2> 5540 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5540 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10005 (1416340636265611264)]} 0 4
[junit4:junit4]   2> 5543 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[10005 (-1416340636272951296)]} 0 0
[junit4:junit4]   2> 5548 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5549 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[10005 (-1416340636276097024)]} 0 3
[junit4:junit4]   2> 5551 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10006 (1416340636281339904)]} 0 0
[junit4:junit4]   2> 5561 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 5561 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10006 (1416340636284485632)]} 0 7
[junit4:junit4]   2> 5565 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10007 (1416340636294971392)]} 0 1
[junit4:junit4]   2> 5568 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=14 
[junit4:junit4]   2> 5569 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[5 (1416340636267708416)]} 0 31
[junit4:junit4]   2> 5569 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5570 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10007 (1416340636298117120)]} 0 3
[junit4:junit4]   2> 5572 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[5 (-1416340636303360000)]} 0 0
[junit4:junit4]   2> 5573 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10008 (1416340636303360001)]} 0 1
[junit4:junit4]   2> 5576 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5577 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[5 (-1416340636305457152)]} 0 3
[junit4:junit4]   2> 5578 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5579 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10008 (1416340636306505728)]} 0 4
[junit4:junit4]   2> 5579 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[6 (1416340636310700032)]} 0 0
[junit4:junit4]   2> 5581 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10009 (1416340636312797184)]} 0 0
[junit4:junit4]   2> 5585 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5585 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[6 (1416340636313845760)]} 0 3
[junit4:junit4]   2> 5588 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[7 (1416340636319088640)]} 0 0
[junit4:junit4]   2> 5588 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5589 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10009 (1416340636315942912)]} 0 5
[junit4:junit4]   2> 5593 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5593 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[7 (1416340636322234368)]} 0 3
[junit4:junit4]   2> 5597 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[8 (1416340636328525824)]} 0 1
[junit4:junit4]   2> 5604 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5604 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10010 (1416340636323282944)]} 0 13
[junit4:junit4]   2> 5604 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[8 (1416340636332720128)]} 0 4
[junit4:junit4]   2> 5609 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[9 (1416340636340060160)]} 0 2
[junit4:junit4]   2> 5610 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5611 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10010 (1416340636340060160)]} 0 4
[junit4:junit4]   2> 5613 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10011 (1416340636346351616)]} 0 0
[junit4:junit4]   2> 5621 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5622 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[9 (1416340636344254464)]} 0 11
[junit4:junit4]   2> 5624 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10 (1416340636357885952)]} 0 0
[junit4:junit4]   2> 5635 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 5636 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10011 (1416340636349497344)]} 0 20
[junit4:junit4]   2> 5638 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10012 (1416340636372566016)]} 0 0
[junit4:junit4]   2> 5645 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5645 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10012 (1416340636375711744)]} 0 4
[junit4:junit4]   2> 5646 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=14 
[junit4:junit4]   2> 5647 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10 (1416340636361031680)]} 0 20
[junit4:junit4]   2> 5647 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10013 (1416340636382003200)]} 0 0
[junit4:junit4]   2> 5649 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[11 (1416340636384100352)]} 0 0
[junit4:junit4]   2> 5653 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5653 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10013 (1416340636385148928)]} 0 3
[junit4:junit4]   2> 5654 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5655 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[11 (1416340636387246080)]} 0 3
[junit4:junit4]   2> 5657 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[12 (1416340636392488960)]} 0 0
[junit4:junit4]   2> 5662 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5663 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[12 (1416340636395634688)]} 0 3
[junit4:junit4]   2> 5665 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[13 (1416340636400877568)]} 0 0
[junit4:junit4]   2> 5669 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10014 (1416340636390391808)]} 0 14
[junit4:junit4]   2> 5672 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5672 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[13 (1416340636404023296)]} 0 4
[junit4:junit4]   2> 5676 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5676 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10014 (1416340636408217600)]} 0 4
[junit4:junit4]   2> 5677 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[14 (1416340636411363328)]} 0 2
[junit4:junit4]   2> 5679 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[10013 (-1416340636415557632)]} 0 0
[junit4:junit4]   2> 5683 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5683 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[14 (1416340636415557632)]} 0 4
[junit4:junit4]   2> 5684 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5684 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[10013 (-1416340636418703360)]} 0 2
[junit4:junit4]   2> 5686 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[13 (-1416340636422897664)]} 0 0
[junit4:junit4]   2> 5688 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10015 (1416340636423946240)]} 0 1
[junit4:junit4]   2> 5691 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5692 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[13 (-1416340636426043392)]} 0 3
[junit4:junit4]   2> 5693 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5694 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10015 (1416340636427091968)]} 0 4
[junit4:junit4]   2> 5694 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[15 (1416340636431286272)]} 0 0
[junit4:junit4]   2> 5696 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[10014 (-1416340636433383424)]} 0 0
[junit4:junit4]   2> 5701 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5702 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[10014 (-1416340636436529152)]} 0 3
[junit4:junit4]   2> 5705 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10016 (1416340636441772032)]} 0 1
[junit4:junit4]   2> 5715 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5716 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[15 (1416340636434432000)]} 0 19
[junit4:junit4]   2> 5718 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[14 (-1416340636456452096)]} 0 0
[junit4:junit4]   2> 5724 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5724 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[14 (-1416340636459597824)]} 0 3
[junit4:junit4]   2> 5725 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=14 
[junit4:junit4]   2> 5726 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10016 (1416340636444917760)]} 0 19
[junit4:junit4]   2> 5728 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[16 (1416340636465889280)]} 0 1
[junit4:junit4]   2> 5728 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[10016 (-1416340636466937856)]} 0 0
[junit4:junit4]   2> 5734 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5734 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5734 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[10016 (-1416340636470083584)]} 0 3
[junit4:junit4]   2> 5734 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[16 (1416340636469035008)]} 0 4
[junit4:junit4]   2> 5737 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[16 (-1416340636476375040)]} 0 0
[junit4:junit4]   2> 5738 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10017 (1416340636476375041)]} 0 1
[junit4:junit4]   2> 5742 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5742 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5743 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[16 (-1416340636479520769)]} 0 3
[junit4:junit4]   2> 5743 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10017 (1416340636479520768)]} 0 3
[junit4:junit4]   2> 5745 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[17 (1416340636484763649)]} 0 0
[junit4:junit4]   2> 5751 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5752 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[17 (1416340636487909376)]} 0 4
[junit4:junit4]   2> 5756 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[18 (1416340636495249408)]} 0 1
[junit4:junit4]   2> 5759 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10018 (1416340636484763648)]} 0 14
[junit4:junit4]   2> 5761 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5762 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[18 (1416340636498395136)]} 0 4
[junit4:junit4]   2> 5764 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5765 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10018 (1416340636502589440)]} 0 3
[junit4:junit4]   2> 5765 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[19 (1416340636504686592)]} 0 1
[junit4:junit4]   2> 5768 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10019 (1416340636507832320)]} 0 1
[junit4:junit4]   2> 5771 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5772 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[19 (1416340636508880896)]} 0 4
[junit4:junit4]   2> 5772 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5773 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10019 (1416340636510978048)]} 0 3
[junit4:junit4]   2> 5775 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[19 (-1416340636515172352)]} 0 1
[junit4:junit4]   2> 5775 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[10019 (-1416340636516220928)]} 0 0
[junit4:junit4]   2> 5779 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5780 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[19 (-1416340636518318080)]} 0 3
[junit4:junit4]   2> 5780 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5781 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[10019 (-1416340636519366656)]} 0 3
[junit4:junit4]   2> 5782 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[20 (1416340636523560960)]} 0 0
[junit4:junit4]   2> 5784 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10020 (1416340636524609536)]} 0 1
[junit4:junit4]   2> 5787 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5788 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[20 (1416340636526706688)]} 0 3
[junit4:junit4]   2> 5790 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[20 (-1416340636531949568)]} 0 0
[junit4:junit4]   2> 5795 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5795 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[20 (-1416340636535095296)]} 0 2
[junit4:junit4]   2> 5799 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[21 (1416340636540338176)]} 0 1
[junit4:junit4]   2> 5807 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 5807 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[21 (1416340636543483904)]} 0 6
[junit4:junit4]   2> 5815 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=14 
[junit4:junit4]   2> 5815 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10020 (1416340636527755264)]} 0 29
[junit4:junit4]   2> 5819 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[10020 (-1416340636562358272)]} 0 1
[junit4:junit4]   2> 5823 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5824 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[10020 (-1416340636564455424)]} 0 3
[junit4:junit4]   2> 5824 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[22 (1416340636552921088)]} 0 14
[junit4:junit4]   2> 5827 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10021 (1416340636569698304)]} 0 1
[junit4:junit4]   2> 5830 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5830 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[22 (1416340636570746880)]} 0 3
[junit4:junit4]   2> 5833 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5833 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[23 (1416340636575989760)]} 0 1
[junit4:junit4]   2> 5833 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10021 (1416340636572844032)]} 0 4
[junit4:junit4]   2> 5835 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10022 (1416340636579135488)]} 0 0
[junit4:junit4]   2> 5838 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5839 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[23 (1416340636579135488)]} 0 4
[junit4:junit4]   2> 5842 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[22 (-1416340636586475520)]} 0 1
[junit4:junit4]   2> 5842 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5843 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10022 (1416340636582281216)]} 0 5
[junit4:junit4]   2> 5846 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10023 (1416340636589621248)]} 0 1
[junit4:junit4]   2> 5847 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5848 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[22 (-1416340636589621248)]} 0 3
[junit4:junit4]   2> 5850 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[24 (1416340636594864128)]} 0 0
[junit4:junit4]   2> 5851 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5852 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10023 (1416340636592766976)]} 0 4
[junit4:junit4]   2> 5854 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[10022 (-1416340636599058432)]} 0 0
[junit4:junit4]   2> 5857 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5858 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[24 (1416340636599058432)]} 0 4
[junit4:junit4]   2> 5859 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5860 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[10022 (-1416340636602204160)]} 0 3
[junit4:junit4]   2> 5860 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[25 (1416340636605349888)]} 0 0
[junit4:junit4]   2> 5864 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10024 (1416340636607447040)]} 0 2
[junit4:junit4]   2> 5865 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5866 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[25 (1416340636608495616)]} 0 3
[junit4:junit4]   2> 5868 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[26 (1416340636613738496)]} 0 0
[junit4:junit4]   2> 5868 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5869 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10024 (1416340636611641344)]} 0 3
[junit4:junit4]   2> 5871 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10025 (1416340636616884224)]} 0 0
[junit4:junit4]   2> 5891 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 5891 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[26 (1416340636616884224)]} 0 20
[junit4:junit4]   2> 5894 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=14 
[junit4:junit4]   2> 5894 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10025 (1416340636622127104)]} 0 18
[junit4:junit4]   2> 5895 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[27 (1416340636641001472)]} 0 1
[junit4:junit4]   2> 5897 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10026 (1416340636644147200)]} 0 0
[junit4:junit4]   2> 5901 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5901 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[27 (1416340636644147200)]} 0 4
[junit4:junit4]   2> 5904 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5904 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10026 (1416340636647292928)]} 0 4
[junit4:junit4]   2> 5906 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10027 (1416340636653584384)]} 0 0
[junit4:junit4]   2> 5912 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5913 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10027 (1416340636656730112)]} 0 4
[junit4:junit4]   2> 5915 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10028 (1416340636663021568)]} 0 0
[junit4:junit4]   2> 5917 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[28 (1416340636650438656)]} 0 14
[junit4:junit4]   2> 5920 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5921 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10028 (1416340636666167296)]} 0 3
[junit4:junit4]   2> 5921 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5922 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[28 (1416340636667215872)]} 0 3
[junit4:junit4]   2> 5923 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[10025 (-1416340636671410176)]} 0 0
[junit4:junit4]   2> 5924 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[25 (-1416340636672458752)]} 0 0
[junit4:junit4]   2> 5928 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5928 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[10025 (-1416340636674555904)]} 0 2
[junit4:junit4]   2> 5929 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5930 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[25 (-1416340636675604480)]} 0 3
[junit4:junit4]   2> 5932 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10029 (1416340636679798784)]} 0 1
[junit4:junit4]   2> 5934 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[29 (1416340636680847360)]} 0 2
[junit4:junit4]   2> 5937 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5938 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10029 (1416340636682944512)]} 0 4
[junit4:junit4]   2> 5938 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5939 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[29 (1416340636685041664)]} 0 3
[junit4:junit4]   2> 5940 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10030 (1416340636689235968)]} 0 0
[junit4:junit4]   2> 5941 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[30 (1416340636690284544)]} 0 0
[junit4:junit4]   2> 5945 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5946 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10030 (1416340636692381696)]} 0 3
[junit4:junit4]   2> 5948 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[10027 (-1416340636697624576)]} 0 0
[junit4:junit4]   2> 5954 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5955 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[10027 (-1416340636700770304)]} 0 4
[junit4:junit4]   2> 5958 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10031 (1416340636707061760)]} 0 1
[junit4:junit4]   2> 5966 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 5966 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10031 (1416340636710207488)]} 0 6
[junit4:junit4]   2> 5972 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=13 
[junit4:junit4]   2> 5973 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[30 (1416340636693430272)]} 0 29
[junit4:junit4]   2> 5976 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[27 (-1416340636726984704)]} 0 0
[junit4:junit4]   2> 5982 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5982 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10032 (1416340636719644672)]} 0 13
[junit4:junit4]   2> 5982 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[27 (-1416340636730130432)]} 0 3
[junit4:junit4]   2> 5986 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[31 (1416340636736421888)]} 0 1
[junit4:junit4]   2> 5988 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5989 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10032 (1416340636736421888)]} 0 4
[junit4:junit4]   2> 5991 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[10031 (-1416340636742713344)]} 0 0
[junit4:junit4]   2> 5991 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 5992 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[31 (1416340636740616192)]} 0 3
[junit4:junit4]   2> 5994 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[32 (1416340636745859072)]} 0 0
[junit4:junit4]   2> 5997 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 5997 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[10031 (-1416340636745859072)]} 0 3
[junit4:junit4]   2> 6000 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6000 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10033 (1416340636752150528)]} 0 0
[junit4:junit4]   2> 6001 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[32 (1416340636749004800)]} 0 4
[junit4:junit4]   2> 6003 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[31 (-1416340636755296256)]} 0 0
[junit4:junit4]   2> 6005 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6006 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10033 (1416340636755296256)]} 0 3
[junit4:junit4]   2> 6008 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6008 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10034 (1416340636760539136)]} 0 0
[junit4:junit4]   2> 6009 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[31 (-1416340636758441984)]} 0 3
[junit4:junit4]   2> 6011 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[33 (1416340636763684864)]} 0 0
[junit4:junit4]   2> 6013 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6014 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10034 (1416340636763684864)]} 0 3
[junit4:junit4]   2> 6016 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[10034 (-1416340636768927744)]} 0 0
[junit4:junit4]   2> 6017 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6018 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[33 (1416340636766830592)]} 0 4
[junit4:junit4]   2> 6020 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6020 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[34 (1416340636773122048)]} 0 0
[junit4:junit4]   2> 6020 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[10034 (-1416340636771024896)]} 0 2
[junit4:junit4]   2> 6023 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10035 (1416340636776267776)]} 0 0
[junit4:junit4]   2> 6026 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6027 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[34 (1416340636776267776)]} 0 4
[junit4:junit4]   2> 6029 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6029 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10035 (1416340636779413504)]} 0 3
[junit4:junit4]   2> 6029 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[34 (-1416340636782559232)]} 0 0
[junit4:junit4]   2> 6032 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10036 (1416340636784656384)]} 0 1
[junit4:junit4]   2> 6034 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6035 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[34 (-1416340636785704960)]} 0 3
[junit4:junit4]   2> 6038 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[35 (1416340636790947840)]} 0 1
[junit4:junit4]   2> 6063 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 6064 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10036 (1416340636787802112)]} 0 30
[junit4:junit4]   2> 6066 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=21 
[junit4:junit4]   2> 6066 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[35 (1416340636794093568)]} 0 26
[junit4:junit4]   2> 6068 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10037 (1416340636822405120)]} 0 1
[junit4:junit4]   2> 6070 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[36 (1416340636824502272)]} 0 1
[junit4:junit4]   2> 6074 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6074 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10037 (1416340636825550848)]} 0 4
[junit4:junit4]   2> 6076 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6076 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[36 (1416340636827648000)]} 0 4
[junit4:junit4]   2> 6077 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[10036 (-1416340636832890880)]} 0 0
[junit4:junit4]   2> 6080 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[37 (1416340636834988032)]} 0 1
[junit4:junit4]   2> 6082 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6083 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[10036 (-1416340636836036608)]} 0 3
[junit4:junit4]   2> 6086 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6086 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[37 (1416340636838133760)]} 0 4
[junit4:junit4]   2> 6087 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10038 (1416340636842328064)]} 0 1
[junit4:junit4]   2> 6089 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[36 (-1416340636845473792)]} 0 0
[junit4:junit4]   2> 6093 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6093 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10038 (1416340636845473792)]} 0 4
[junit4:junit4]   2> 6095 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6096 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[36 (-1416340636848619520)]} 0 4
[junit4:junit4]   2> 6097 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10039 (1416340636852813824)]} 0 1
[junit4:junit4]   2> 6100 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[38 (1416340636855959552)]} 0 1
[junit4:junit4]   2> 6103 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6103 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10039 (1416340636855959552)]} 0 4
[junit4:junit4]   2> 6106 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6106 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[38 (1416340636859105280)]} 0 4
[junit4:junit4]   2> 6107 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10040 (1416340636863299584)]} 0 1
[junit4:junit4]   2> 6114 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6114 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10040 (1416340636866445312)]} 0 5
[junit4:junit4]   2> 6117 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[10040 (-1416340636874833920)]} 0 0
[junit4:junit4]   2> 6122 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6123 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[10040 (-1416340636877979648)]} 0 3
[junit4:junit4]   2> 6127 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[39 (1416340636866445312)]} 0 18
[junit4:junit4]   2> 6134 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6134 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[39 (1416340636888465408)]} 0 4
[junit4:junit4]   2> 6139 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[40 (1416340636895805440)]} 0 2
[junit4:junit4]   2> 6294 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10041 (1416340636883222528)]} 0 169
[junit4:junit4]   2> 6379 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 6380 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[40 (1416340636901048320)]} 0 238
[junit4:junit4]   2> 6383 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[40 (-1416340637153755136)]} 0 0
[junit4:junit4]   2> 6388 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6389 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[40 (-1416340637156900864)]} 0 3
[junit4:junit4]   2> 6395 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[41 (1416340637163192320)]} 0 3
[junit4:junit4]   2> 6402 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6402 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[41 (1416340637169483776)]} 0 4
[junit4:junit4]   2> 6406 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[42 (1416340637176823808)]} 0 1
[junit4:junit4]   2> 6412 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6412 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[42 (1416340637179969536)]} 0 4
[junit4:junit4]   2> 6416 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[43 (1416340637187309568)]} 0 1
[junit4:junit4]   2> 6423 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6424 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[43 (1416340637191503872)]} 0 5
[junit4:junit4]   2> 6428 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[44 (1416340637199892480)]} 0 1
[junit4:junit4]   2> 6435 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6436 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[44 (1416340637204086784)]} 0 6
[junit4:junit4]   2> 6440 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[45 (1416340637212475392)]} 0 1
[junit4:junit4]   2> 6447 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6448 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[45 (1416340637216669696)]} 0 5
[junit4:junit4]   2> 6452 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[46 (1416340637225058304)]} 0 1
[junit4:junit4]   2> 6459 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6460 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[46 (1416340637229252608)]} 0 5
[junit4:junit4]   2> 6463 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[42 (-1416340637237641216)]} 0 1
[junit4:junit4]   2> 6469 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6469 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[42 (-1416340637240786944)]} 0 3
[junit4:junit4]   2> 6474 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[47 (1416340637247078400)]} 0 1
[junit4:junit4]   2> 6480 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6480 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[47 (1416340637251272704)]} 0 4
[junit4:junit4]   2> 6483 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[43 (-1416340637258612736)]} 0 0
[junit4:junit4]   2> 6488 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6489 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[43 (-1416340637261758464)]} 0 3
[junit4:junit4]   2> 6492 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[48 (1416340637267001344)]} 0 1
[junit4:junit4]   2> 6498 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6498 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[48 (1416340637270147072)]} 0 4
[junit4:junit4]   2> 6501 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[47 (-1416340637277487104)]} 0 0
[junit4:junit4]   2> 6508 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6510 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[47 (-1416340637280632832)]} 0 6
[junit4:junit4]   2> 6513 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[49 (1416340637289021440)]} 0 1
[junit4:junit4]   2> 6577 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=274 
[junit4:junit4]   2> 6578 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10041 (1416340637064626176)]} 0 281
[junit4:junit4]   2> 6625 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10042 (1416340637361373184)]} 0 44
[junit4:junit4]   2> 6635 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 6636 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10042 (1416340637411704832)]} 0 8
[junit4:junit4]   2> 6642 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10043 (1416340637422190592)]} 0 3
[junit4:junit4]   2> 6649 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6649 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10043 (1416340637428482048)]} 0 4
[junit4:junit4]   2> 6653 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10044 (1416340637435822080)]} 0 1
[junit4:junit4]   2> 6656 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=27 
[junit4:junit4]   2> 6657 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[49 (1416340637293215744)]} 0 141
[junit4:junit4]   2> 6659 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6659 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10044 (1416340637438967808)]} 0 4
[junit4:junit4]   2> 6661 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[50 (1416340637444210688)]} 0 1
[junit4:junit4]   2> 6663 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10045 (1416340637446307840)]} 0 1
[junit4:junit4]   2> 6667 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6667 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[50 (1416340637447356416)]} 0 4
[junit4:junit4]   2> 6669 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6669 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10045 (1416340637449453568)]} 0 4
[junit4:junit4]   2> 6670 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[49 (-1416340637454696448)]} 0 0
[junit4:junit4]   2> 6672 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10046 (1416340637456793600)]} 0 0
[junit4:junit4]   2> 6675 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6676 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[49 (-1416340637457842176)]} 0 3
[junit4:junit4]   2> 6678 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6679 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[51 (1416340637463085056)]} 0 1
[junit4:junit4]   2> 6679 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10046 (1416340637459939328)]} 0 4
[junit4:junit4]   2> 6682 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[10042 (-1416340637467279360)]} 0 0
[junit4:junit4]   2> 6685 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6685 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[51 (1416340637466230784)]} 0 4
[junit4:junit4]   2> 6687 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6688 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[10042 (-1416340637470425088)]} 0 3
[junit4:junit4]   2> 6689 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[52 (1416340637473570816)]} 0 1
[junit4:junit4]   2> 6690 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10047 (1416340637475667968)]} 0 0
[junit4:junit4]   2> 6695 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6695 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[52 (1416340637476716544)]} 0 4
[junit4:junit4]   2> 6697 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6697 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10047 (1416340637478813696)]} 0 4
[junit4:junit4]   2> 6699 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[53 (1416340637484056576)]} 0 1
[junit4:junit4]   2> 6700 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[10043 (-1416340637486153728)]} 0 0
[junit4:junit4]   2> 6705 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6706 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[10043 (-1416340637489299456)]} 0 3
[junit4:junit4]   2> 6710 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10048 (1416340637495590912)]} 0 1
[junit4:junit4]   2> 6740 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 6740 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[53 (1416340637487202304)]} 0 39
[junit4:junit4]   2> 6743 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[51 (-1416340637531242496)]} 0 0
[junit4:junit4]   2> 6748 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6749 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[51 (-1416340637534388224)]} 0 3
[junit4:junit4]   2> 6752 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[54 (1416340637539631104)]} 0 1
[junit4:junit4]   2> 6758 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6758 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[54 (1416340637542776832)]} 0 4
[junit4:junit4]   2> 6762 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[55 (1416340637550116864)]} 0 1
[junit4:junit4]   2> 6768 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6768 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[55 (1416340637553262592)]} 0 4
[junit4:junit4]   2> 6771 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[53 (-1416340637560602624)]} 0 0
[junit4:junit4]   2> 6772 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=55 
[junit4:junit4]   2> 6772 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10048 (1416340637498736640)]} 0 60
[junit4:junit4]   2> 6775 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[10047 (-1416340637564796928)]} 0 0
[junit4:junit4]   2> 6776 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6777 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[53 (-1416340637563748352)]} 0 3
[junit4:junit4]   2> 6780 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6781 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[10047 (-1416340637567942656)]} 0 3
[junit4:junit4]   2> 6785 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10049 (1416340637574234112)]} 0 1
[junit4:junit4]   2> 6791 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6791 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10049 (1416340637577379840)]} 0 4
[junit4:junit4]   2> 6795 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10050 (1416340637584719872)]} 0 1
[junit4:junit4]   2> 6798 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[56 (1416340637568991232)]} 0 19
[junit4:junit4]   2> 6801 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6801 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10050 (1416340637587865600)]} 0 4
[junit4:junit4]   2> 6804 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[10049 (-1416340637595205632)]} 0 0
[junit4:junit4]   2> 6805 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6805 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[56 (1416340637592059904)]} 0 4
[junit4:junit4]   2> 6809 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6810 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[10049 (-1416340637598351360)]} 0 3
[junit4:junit4]   2> 6810 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[57 (1416340637599399936)]} 0 2
[junit4:junit4]   2> 6814 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10051 (1416340637604642816)]} 0 1
[junit4:junit4]   2> 6817 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6817 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[57 (1416340637604642816)]} 0 4
[junit4:junit4]   2> 6820 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6820 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10051 (1416340637607788544)]} 0 4
[junit4:junit4]   2> 6821 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[58 (1416340637611982848)]} 0 1
[junit4:junit4]   2> 6824 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10052 (1416340637615128576)]} 0 1
[junit4:junit4]   2> 6826 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6827 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[58 (1416340637615128576)]} 0 4
[junit4:junit4]   2> 6830 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[54 (-1416340637622468608)]} 0 0
[junit4:junit4]   2> 6835 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6836 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[54 (-1416340637625614336)]} 0 3
[junit4:junit4]   2> 6839 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[59 (1416340637630857216)]} 0 1
[junit4:junit4]   2> 6847 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 6848 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[59 (1416340637634002944)]} 0 7
[junit4:junit4]   2> 6851 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[55 (-1416340637644488704)]} 0 0
[junit4:junit4]   2> 6857 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6858 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[55 (-1416340637647634432)]} 0 4
[junit4:junit4]   2> 6858 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=15 
[junit4:junit4]   2> 6859 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10052 (1416340637618274304)]} 0 33
[junit4:junit4]   2> 6862 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[60 (1416340637654974464)]} 0 1
[junit4:junit4]   2> 6862 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10053 (1416340637654974465)]} 0 1
[junit4:junit4]   2> 6869 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6869 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6869 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[60 (1416340637659168769)]} 0 4
[junit4:junit4]   2> 6870 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10053 (1416340637659168768)]} 0 5
[junit4:junit4]   2> 6872 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[10051 (-1416340637666508800)]} 0 0
[junit4:junit4]   2> 6873 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[61 (1416340637666508801)]} 0 1
[junit4:junit4]   2> 6877 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6878 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[10051 (-1416340637669654528)]} 0 3
[junit4:junit4]   2> 6879 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6879 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[61 (1416340637669654529)]} 0 4
[junit4:junit4]   2> 6881 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10054 (1416340637674897408)]} 0 1
[junit4:junit4]   2> 6887 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6887 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10054 (1416340637678043136)]} 0 4
[junit4:junit4]   2> 6891 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10055 (1416340637685383168)]} 0 1
[junit4:junit4]   2> 6897 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6897 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10055 (1416340637688528896)]} 0 4
[junit4:junit4]   2> 6897 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[62 (1416340637676994560)]} 0 15
[junit4:junit4]   2> 6900 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[10053 (-1416340637695868928)]} 0 0
[junit4:junit4]   2> 6904 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6904 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[62 (1416340637695868928)]} 0 4
[junit4:junit4]   2> 6905 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6906 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[10053 (-1416340637699014656)]} 0 3
[junit4:junit4]   2> 6908 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[63 (1416340637703208960)]} 0 1
[junit4:junit4]   2> 6910 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10056 (1416340637704257536)]} 0 2
[junit4:junit4]   2> 6914 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6914 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[63 (1416340637706354688)]} 0 4
[junit4:junit4]   2> 6916 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6916 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10056 (1416340637708451840)]} 0 4
[junit4:junit4]   2> 6917 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[56 (-1416340637713694720)]} 0 0
[junit4:junit4]   2> 6920 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10057 (1416340637715791872)]} 0 1
[junit4:junit4]   2> 6922 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6923 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[56 (-1416340637716840448)]} 0 3
[junit4:junit4]   2> 6940 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[64 (1416340637722083328)]} 0 15
[junit4:junit4]   2> 6949 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 6949 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[64 (1416340637740957696)]} 0 6
[junit4:junit4]   2> 6954 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[65 (1416340637750394880)]} 0 2
[junit4:junit4]   2> 6958 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=19 
[junit4:junit4]   2> 6959 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10057 (1416340637718937600)]} 0 37
[junit4:junit4]   2> 6961 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6961 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[65 (1416340637755637760)]} 0 4
[junit4:junit4]   2> 6961 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10058 (1416340637759832064)]} 0 0
[junit4:junit4]   2> 6965 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[66 (1416340637762977792)]} 0 1
[junit4:junit4]   2> 6967 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6968 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10058 (1416340637762977792)]} 0 4
[junit4:junit4]   2> 6970 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[10054 (-1416340637769269248)]} 0 0
[junit4:junit4]   2> 6971 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6972 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[66 (1416340637767172096)]} 0 4
[junit4:junit4]   2> 6975 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6976 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[10054 (-1416340637772414976)]} 0 3
[junit4:junit4]   2> 6976 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[67 (1416340637774512128)]} 0 1
[junit4:junit4]   2> 6979 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10059 (1416340637777657856)]} 0 1
[junit4:junit4]   2> 6983 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 6983 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[67 (1416340637778706432)]} 0 4
[junit4:junit4]   2> 6984 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6985 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[58 (-1416340637784997888)]} 0 0
[junit4:junit4]   2> 6986 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10059 (1416340637780803584)]} 0 5
[junit4:junit4]   2> 6989 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[10055 (-1416340637789192192)]} 0 0
[junit4:junit4]   2> 6990 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6991 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[58 (-1416340637788143616)]} 0 3
[junit4:junit4]   2> 6994 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[68 (1416340637793386496)]} 0 1
[junit4:junit4]   2> 6994 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 6995 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[10055 (-1416340637792337920)]} 0 3
[junit4:junit4]   2> 6997 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10060 (1416340637797580800)]} 0 0
[junit4:junit4]   2> 6999 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7000 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[68 (1416340637796532224)]} 0 4
[junit4:junit4]   2> 7002 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[69 (1416340637802823680)]} 0 0
[junit4:junit4]   2> 7003 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7004 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10060 (1416340637800726528)]} 0 4
[junit4:junit4]   2> 7007 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10061 (1416340637808066560)]} 0 0
[junit4:junit4]   2> 7009 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7010 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[69 (1416340637807017984)]} 0 4
[junit4:junit4]   2> 7012 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[61 (-1416340637813309440)]} 0 0
[junit4:junit4]   2> 7017 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7018 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[61 (-1416340637816455168)]} 0 3
[junit4:junit4]   2> 7020 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[70 (1416340637821698048)]} 0 0
[junit4:junit4]   2> 7040 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7040 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10061 (1416340637811212288)]} 0 30
[junit4:junit4]   2> 7042 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=15 
[junit4:junit4]   2> 7042 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[70 (1416340637824843776)]} 0 19
[junit4:junit4]   2> 7043 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10062 (1416340637845815296)]} 0 0
[junit4:junit4]   2> 7045 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[62 (-1416340637847912448)]} 0 0
[junit4:junit4]   2> 7049 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7050 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7051 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[62 (-1416340637851058176)]} 0 3
[junit4:junit4]   2> 7051 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10062 (1416340637848961024)]} 0 5
[junit4:junit4]   2> 7053 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[71 (1416340637856301057)]} 0 0
[junit4:junit4]   2> 7059 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7060 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[71 (1416340637859446784)]} 0 4
[junit4:junit4]   2> 7062 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[72 (1416340637865738240)]} 0 0
[junit4:junit4]   2> 7066 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10063 (1416340637856301056)]} 0 13
[junit4:junit4]   2> 7071 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7072 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10063 (1416340637872029696)]} 0 4
[junit4:junit4]   2> 7074 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[10056 (-1416340637878321152)]} 0 0
[junit4:junit4]   2> 7078 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7079 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[10056 (-1416340637880418304)]} 0 3
[junit4:junit4]   2> 7081 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10064 (1416340637885661184)]} 0 0
[junit4:junit4]   2> 7084 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7085 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[72 (1416340637885661184)]} 0 4
[junit4:junit4]   2> 7086 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7087 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10064 (1416340637888806912)]} 0 3
[junit4:junit4]   2> 7087 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[66 (-1416340637891952640)]} 0 0
[junit4:junit4]   2> 7092 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7092 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10065 (1416340637895098368)]} 0 2
[junit4:junit4]   2> 7093 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[66 (-1416340637895098368)]} 0 3
[junit4:junit4]   2> 7096 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[73 (1416340637900341248)]} 0 1
[junit4:junit4]   2> 7099 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7099 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10065 (1416340637900341248)]} 0 4
[junit4:junit4]   2> 7103 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10066 (1416340637907681280)]} 0 1
[junit4:junit4]   2> 7103 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7104 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[73 (1416340637904535552)]} 0 5
[junit4:junit4]   2> 7107 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[74 (1416340637911875584)]} 0 1
[junit4:junit4]   2> 7109 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7109 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10066 (1416340637910827008)]} 0 4
[junit4:junit4]   2> 7113 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10067 (1416340637918167040)]} 0 1
[junit4:junit4]   2> 7127 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7128 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[74 (1416340637915021312)]} 0 19
[junit4:junit4]   2> 7132 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[75 (1416340637938089984)]} 0 1
[junit4:junit4]   2> 7138 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7139 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[75 (1416340637942284288)]} 0 4
[junit4:junit4]   2> 7139 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=18 
[junit4:junit4]   2> 7140 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10067 (1416340637922361344)]} 0 24
[junit4:junit4]   2> 7142 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[10058 (-1416340637949624320)]} 0 0
[junit4:junit4]   2> 7143 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[76 (1416340637949624321)]} 0 1
[junit4:junit4]   2> 7147 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7148 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[10058 (-1416340637952770048)]} 0 3
[junit4:junit4]   2> 7148 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7149 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[76 (1416340637952770049)]} 0 4
[junit4:junit4]   2> 7151 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10068 (1416340637958012928)]} 0 1
[junit4:junit4]   2> 7151 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[77 (1416340637959061504)]} 0 0
[junit4:junit4]   2> 7157 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7158 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7158 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[77 (1416340637962207232)]} 0 4
[junit4:junit4]   2> 7158 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10068 (1416340637962207233)]} 0 4
[junit4:junit4]   2> 7162 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10069 (1416340637969547265)]} 0 1
[junit4:junit4]   2> 7162 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[78 (1416340637969547264)]} 0 1
[junit4:junit4]   2> 7169 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7169 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7169 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[78 (1416340637973741568)]} 0 4
[junit4:junit4]   2> 7170 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10069 (1416340637973741569)]} 0 5
[junit4:junit4]   2> 7172 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[10061 (-1416340637981081600)]} 0 0
[junit4:junit4]   2> 7177 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7178 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[10061 (-1416340637984227328)]} 0 3
[junit4:junit4]   2> 7182 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10070 (1416340637990518784)]} 0 1
[junit4:junit4]   2> 7188 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7188 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10070 (1416340637993664512)]} 0 4
[junit4:junit4]   2> 7191 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[79 (1416340637981081601)]} 0 19
[junit4:junit4]   2> 7191 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[10062 (-1416340638001004544)]} 0 0
[junit4:junit4]   2> 7196 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7197 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7197 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[10062 (-1416340638004150272)]} 0 3
[junit4:junit4]   2> 7197 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[79 (1416340638003101696)]} 0 4
[junit4:junit4]   2> 7200 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[68 (-1416340638010441729)]} 0 0
[junit4:junit4]   2> 7205 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7206 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[68 (-1416340638013587456)]} 0 3
[junit4:junit4]   2> 7211 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[80 (1416340638019878912)]} 0 2
[junit4:junit4]   2> 7342 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10071 (1416340638010441728)]} 0 142
[junit4:junit4]   2> 7432 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 7433 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[80 (1416340638025121792)]} 0 219
[junit4:junit4]   2> 7439 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[81 (1416340638257905664)]} 0 3
[junit4:junit4]   2> 7446 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7446 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[81 (1416340638264197120)]} 0 4
[junit4:junit4]   2> 7450 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[82 (1416340638271537152)]} 0 1
[junit4:junit4]   2> 7457 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7457 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[82 (1416340638275731456)]} 0 4
[junit4:junit4]   2> 7460 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[70 (-1416340638283071488)]} 0 0
[junit4:junit4]   2> 7465 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7466 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[70 (-1416340638286217216)]} 0 3
[junit4:junit4]   2> 7470 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[83 (1416340638292508672)]} 0 1
[junit4:junit4]   2> 7477 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7477 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[83 (1416340638296702976)]} 0 4
[junit4:junit4]   2> 7480 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[71 (-1416340638304043008)]} 0 0
[junit4:junit4]   2> 7485 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7486 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[71 (-1416340638307188736)]} 0 3
[junit4:junit4]   2> 7490 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[84 (1416340638313480192)]} 0 1
[junit4:junit4]   2> 7497 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7497 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[84 (1416340638317674496)]} 0 4
[junit4:junit4]   2> 7501 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[85 (1416340638325014528)]} 0 1
[junit4:junit4]   2> 7508 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7508 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[85 (1416340638329208832)]} 0 4
[junit4:junit4]   2> 7512 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[74 (-1416340638336548864)]} 0 1
[junit4:junit4]   2> 7516 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7517 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[74 (-1416340638339694592)]} 0 3
[junit4:junit4]   2> 7520 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=169 
[junit4:junit4]   2> 7521 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10071 (1416340638163533824)]} 0 176
[junit4:junit4]   2> 7521 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[86 (1416340638345986048)]} 0 1
[junit4:junit4]   2> 7525 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10072 (1416340638350180352)]} 0 1
[junit4:junit4]   2> 7528 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7528 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[86 (1416340638350180352)]} 0 4
[junit4:junit4]   2> 7531 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[75 (-1416340638357520384)]} 0 0
[junit4:junit4]   2> 7532 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7532 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10072 (1416340638354374656)]} 0 4
[junit4:junit4]   2> 7535 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[10066 (-1416340638361714688)]} 0 0
[junit4:junit4]   2> 7536 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7537 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[75 (-1416340638360666112)]} 0 3
[junit4:junit4]   2> 7540 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7540 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[87 (1416340638365908992)]} 0 1
[junit4:junit4]   2> 7541 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[10066 (-1416340638364860416)]} 0 3
[junit4:junit4]   2> 7544 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10073 (1416340638370103296)]} 0 1
[junit4:junit4]   2> 7547 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7547 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[87 (1416340638370103296)]} 0 4
[junit4:junit4]   2> 7550 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[76 (-1416340638377443328)]} 0 0
[junit4:junit4]   2> 7555 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7556 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[76 (-1416340638380589056)]} 0 3
[junit4:junit4]   2> 7559 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[88 (1416340638385831936)]} 0 1
[junit4:junit4]   2> 7606 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=39 
[junit4:junit4]   2> 7607 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[88 (1416340638390026240)]} 0 45
[junit4:junit4]   2> 7611 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[89 (1416340638440357888)]} 0 1
[junit4:junit4]   2> 7620 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 7620 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[89 (1416340638444552192)]} 0 6
[junit4:junit4]   2> 7624 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[90 (1416340638453989376)]} 0 1
[junit4:junit4]   2> 7628 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7628 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10073 (1416340638373249024)]} 0 82
[junit4:junit4]   2> 7631 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7631 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10074 (1416340638462377984)]} 0 0
[junit4:junit4]   2> 7631 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[90 (1416340638458183680)]} 0 4
[junit4:junit4]   2> 7634 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[91 (1416340638465523712)]} 0 0
[junit4:junit4]   2> 7638 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7638 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10074 (1416340638465523712)]} 0 4
[junit4:junit4]   2> 7640 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7641 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[91 (1416340638468669440)]} 0 4
[junit4:junit4]   2> 7643 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[77 (-1416340638474960896)]} 0 0
[junit4:junit4]   2> 7648 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7649 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[77 (-1416340638478106624)]} 0 3
[junit4:junit4]   2> 7652 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[92 (1416340638483349504)]} 0 1
[junit4:junit4]   2> 7656 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7657 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[92 (1416340638486495232)]} 0 3
[junit4:junit4]   2> 7660 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[93 (1416340638491738112)]} 0 1
[junit4:junit4]   2> 7663 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10075 (1416340638472863744)]} 0 22
[junit4:junit4]   2> 7666 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7666 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[93 (1416340638494883840)]} 0 4
[junit4:junit4]   2> 7669 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7669 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10075 (1416340638498029568)]} 0 4
[junit4:junit4]   2> 7671 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[94 (1416340638502223872)]} 0 2
[junit4:junit4]   2> 7673 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10076 (1416340638505369600)]} 0 1
[junit4:junit4]   2> 7677 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7677 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[94 (1416340638506418176)]} 0 4
[junit4:junit4]   2> 7680 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[79 (-1416340638513758208)]} 0 0
[junit4:junit4]   2> 7685 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7686 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[79 (-1416340638516903936)]} 0 3
[junit4:junit4]   2> 7718 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=15 
[junit4:junit4]   2> 7719 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10076 (1416340638509563904)]} 0 43
[junit4:junit4]   2> 7721 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[95 (1416340638523195392)]} 0 32
[junit4:junit4]   2> 7723 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10077 (1416340638557798400)]} 0 1
[junit4:junit4]   2> 7728 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7729 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[95 (1416340638558846976)]} 0 6
[junit4:junit4]   2> 7731 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7731 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10077 (1416340638563041280)]} 0 4
[junit4:junit4]   2> 7731 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[96 (1416340638567235584)]} 0 0
[junit4:junit4]   2> 7736 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10078 (1416340638570381312)]} 0 2
[junit4:junit4]   2> 7737 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7738 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[96 (1416340638570381312)]} 0 4
[junit4:junit4]   2> 7740 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7740 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[97 (1416340638576672768)]} 0 0
[junit4:junit4]   2> 7741 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10078 (1416340638574575616)]} 0 3
[junit4:junit4]   2> 7744 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10079 (1416340638579818496)]} 0 1
[junit4:junit4]   2> 7745 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7748 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7749 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10079 (1416340638582964224)]} 0 3
[junit4:junit4]   2> 7751 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[10068 (-1416340638588207104)]} 0 0
[junit4:junit4]   2> 7752 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[97 (1416340638579818496)]} 0 9
[junit4:junit4]   2> 7754 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[98 (1416340638591352832)]} 0 0
[junit4:junit4]   2> 7756 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7757 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[10068 (-1416340638591352832)]} 0 3
[junit4:junit4]   2> 7759 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10080 (1416340638596595712)]} 0 0
[junit4:junit4]   2> 7759 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7760 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[98 (1416340638594498560)]} 0 3
[junit4:junit4]   2> 7762 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[99 (1416340638599741440)]} 0 0
[junit4:junit4]   2> 7764 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7765 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10080 (1416340638599741440)]} 0 3
[junit4:junit4]   2> 7767 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7767 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10081 (1416340638604984320)]} 0 0
[junit4:junit4]   2> 7768 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[99 (1416340638602887168)]} 0 3
[junit4:junit4]   2> 7770 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[100 (1416340638608130048)]} 0 0
[junit4:junit4]   2> 7788 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7789 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10081 (1416340638608130048)]} 0 19
[junit4:junit4]   2> 7791 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=12 
[junit4:junit4]   2> 7792 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10082 (1416340638630150144)]} 0 1
[junit4:junit4]   2> 7792 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[100 (1416340638612324352)]} 0 18
[junit4:junit4]   2> 7797 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7797 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10082 (1416340638633295872)]} 0 3
[junit4:junit4]   2> 7800 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[10070 (-1416340638639587328)]} 0 0
[junit4:junit4]   2> 7806 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7806 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[10070 (-1416340638642733056)]} 0 3
[junit4:junit4]   2> 7806 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[101 (1416340638633295872)]} 0 12
[junit4:junit4]   2> 7810 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10083 (1416340638649024512)]} 0 1
[junit4:junit4]   2> 7812 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7813 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[101 (1416340638649024512)]} 0 4
[junit4:junit4]   2> 7814 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7815 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[81 (-1416340638655315968)]} 0 0
[junit4:junit4]   2> 7816 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10083 (1416340638652170240)]} 0 4
[junit4:junit4]   2> 7818 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[10071 (-1416340638658461696)]} 0 0
[junit4:junit4]   2> 7820 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7821 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[81 (-1416340638658461696)]} 0 3
[junit4:junit4]   2> 7823 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7823 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[102 (1416340638663704576)]} 0 0
[junit4:junit4]   2> 7824 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[10071 (-1416340638661607424)]} 0 3
[junit4:junit4]   2> 7826 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10084 (1416340638666850304)]} 0 0
[junit4:junit4]   2> 7829 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7830 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[102 (1416340638666850304)]} 0 4
[junit4:junit4]   2> 7831 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7832 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[10084 (1416340638669996032)]} 0 3
[junit4:junit4]   2> 7832 T1410 C74 P55809 /update {wt=javabin&version=2} {delete=[82 (-1416340638673141760)]} 0 0
[junit4:junit4]   2> 7836 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10085 (1416340638675238912)]} 0 2
[junit4:junit4]   2> 7837 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7837 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[82 (-1416340638676287488)]} 0 2
[junit4:junit4]   2> 7840 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[103 (1416340638681530368)]} 0 0
[junit4:junit4]   2> 7841 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7842 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10085 (1416340638679433216)]} 0 4
[junit4:junit4]   2> 7844 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[10074 (-1416340638685724672)]} 0 0
[junit4:junit4]   2> 7845 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7846 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[103 (1416340638684676096)]} 0 3
[junit4:junit4]   2> 7848 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7848 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[104 (1416340638689918976)]} 0 0
[junit4:junit4]   2> 7849 T1426 C73 P55812 /update {wt=javabin&version=2} {delete=[10074 (-1416340638687821824)]} 0 2
[junit4:junit4]   2> 7851 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[10086 (1416340638693064704)]} 0 0
[junit4:junit4]   2> 7853 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7854 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[104 (1416340638693064704)]} 0 3
[junit4:junit4]   2> 7856 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[83 (-1416340638698307584)]} 0 0
[junit4:junit4]   2> 7861 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7862 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[83 (-1416340638701453312)]} 0 3
[junit4:junit4]   2> 7864 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[105 (1416340638706696192)]} 0 0
[junit4:junit4]   2> 7872 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7873 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[105 (1416340638709841920)]} 0 6
[junit4:junit4]   2> 7875 T1411 C74 P55809 /update {wt=javabin&version=2} {add=[106 (1416340638718230528)]} 0 0
[junit4:junit4]   2> 7881 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=12 
[junit4:junit4]   2> 7882 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7882 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10086 (1416340638696210432)]} 0 28
[junit4:junit4]   2> 7882 T1427 C73 P55812 /update {wt=javabin&version=2} {add=[106 (1416340638721376256)]} 0 4
[junit4:junit4]   2> 7884 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[10075 (-1416340638727667712)]} 0 0
[junit4:junit4]   2> 7885 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[107 (1416340638728716288)]} 0 0
[junit4:junit4]   2> 7889 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7890 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[10075 (-1416340638730813440)]} 0 3
[junit4:junit4]   2> 7891 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7891 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[107 (1416340638731862016)]} 0 3
[junit4:junit4]   2> 7892 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[10087 (1416340638736056320)]} 0 0
[junit4:junit4]   2> 7893 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[84 (-1416340638737104896)]} 0 0
[junit4:junit4]   2> 7897 T1436 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7898 T1426 C73 P55812 /update {wt=javabin&version=2} {add=[10087 (1416340638739202048)]} 0 3
[junit4:junit4]   2> 7898 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7899 T1427 C73 P55812 /update {wt=javabin&version=2} {delete=[84 (-1416340638740250624)]} 0 3
[junit4:junit4]   2> 7900 T1411 C74 P55809 /update {wt=javabin&version=2} {delete=[10076 (-1416340638744444928)]} 0 0
[junit4:junit4]   2> 7901 T1410 C74 P55809 /update {wt=javabin&version=2} {add=[108 (1416340638745493504)]} 0 0
[junit4:junit4]   2> 7904 T1437 C72 P55815 REQ /update {distrib.from=http://127.0.0.1:55812/solr/collection1/&update

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

2325 T1398 oasc.ChaosMonkey.monkeyLog monkey: stop shard! 55815
[junit4:junit4]   2> 32325 T1398 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1999151556
[junit4:junit4]   2> 32427 T1506 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 32427 T1398 oaz.ZooKeeper.close Session: 0x13a7da4ca010007 closed
[junit4:junit4]   2> 32430 T1398 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 32725 T1398 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=RecoveryZkTest -Dtests.method=testDistribSearch -Dtests.seed=96B10EBCF436B762 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ar_MA -Dtests.timezone=Etc/GMT-11 -Dtests.file.encoding=ISO-8859-1
[junit4:junit4] ERROR   32.7s J1 | RecoveryZkTest.testDistribSearch <<<
[junit4:junit4]    > Throwable #1: org.apache.solr.common.SolrException: Server at http://127.0.0.1:55815/solr/collection1 returned non ok status:404, message:Can not find: /solr/collection1/select
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([96B10EBCF436B762:175780A48369D75E]:0)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:372)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:181)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:90)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:301)
[junit4:junit4]    > 	at org.apache.solr.cloud.RecoveryZkTest.doTest(RecoveryZkTest.java:92)
[junit4:junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:695)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
[junit4:junit4]    > 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4:junit4]    > 	at java.lang.reflect.Method.invoke(Method.java:601)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 32750 T1398 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4]   2> NOTE: test params are: codec=Lucene41: {range_facet_l=PostingsFormat(name=Lucene41WithOrds), text=PostingsFormat(name=NestedPulsing), _version_=Lucene41(blocksize=128), rnd_b=MockFixedIntBlock(blockSize=1182), intDefault=Lucene41(blocksize=128), timestamp=PostingsFormat(name=Lucene41WithOrds), id=MockFixedIntBlock(blockSize=1182), a_t=PostingsFormat(name=Lucene41WithOrds), range_facet_sl=MockFixedIntBlock(blockSize=1182), range_facet_si=PostingsFormat(name=Lucene41WithOrds), other_tl1=Lucene41(blocksize=128), multiDefault=PostingsFormat(name=Lucene41WithOrds), a_si=Lucene41(blocksize=128)}, sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=ar_MA, timezone=Etc/GMT-11
[junit4:junit4]   2> NOTE: FreeBSD 9.0-RELEASE amd64/Oracle Corporation 1.7.0_06 (64-bit)/cpus=16,threads=1,free=304474144,total=424673280
[junit4:junit4]   2> NOTE: All tests run in this JVM: [DirectUpdateHandlerTest, PingRequestHandlerTest, SolrInfoMBeanTest, TestValueSourceCache, TestBM25SimilarityFactory, AnalysisAfterCoreReloadTest, TestFastWriter, TestSort, TestReplicationHandler, BasicFunctionalityTest, TestPluginEnable, FileUtilsTest, StatsComponentTest, TestPropInject, RAMDirectoryFactoryTest, SignatureUpdateProcessorFactoryTest, BadIndexSchemaTest, IndexReaderFactoryTest, StatelessScriptUpdateProcessorFactoryTest, SolrIndexConfigTest, TestStressReorder, TestQueryUtils, ZkCLITest, TestDistributedGrouping, TestCSVResponseWriter, OverseerTest, ConvertedLegacyTest, TestFoldingMultitermQuery, DebugComponentTest, TestSolrDeletionPolicy2, DOMUtilTest, TestRemoteStreaming, PrimitiveFieldTypeTest, TestSolrCoreProperties, TestDistributedSearch, LegacyHTMLStripCharFilterTest, UUIDFieldTest, TestCSVLoader, TestQuerySenderListener, TestSurroundQueryParser, ShowFileRequestHandlerTest, SolrCoreTest, TestElisionMultitermQuery, TestLRUCache, ZkSolrClientTest, TestCodecSupport, EchoParamsTest, TestPropInjectDefaults, HighlighterTest, TestReversedWildcardFilterFactory, TestOmitPositions, SuggesterTest, ReturnFieldsTest, DocumentAnalysisRequestHandlerTest, StandardRequestHandlerTest, RecoveryZkTest]
[junit4:junit4] Completed on J1 in 32.77s, 1 test, 1 error <<< FAILURES!

[...truncated 425 lines...]
BUILD FAILED
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/build.xml:335: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/build.xml:39: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/solr/build.xml:178: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/lucene/module-build.xml:61: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/lucene/common-build.xml:1170: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-trunk-java7/lucene/common-build.xml:838: There were test failures: 231 suites, 957 tests, 1 error, 21 ignored (3 assumptions)

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



Mime
View raw message