lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@sd-datasolutions.de>
Subject [JENKINS] Lucene-Solr-trunk-Linux (32bit/jdk1.8.0-ea-b51) - Build # 1426 - Failure!
Date Fri, 28 Sep 2012 13:50:39 GMT
Build: http://jenkins.sd-datasolutions.de/job/Lucene-Solr-trunk-Linux/1426/
Java: 32bit/jdk1.8.0-ea-b51 -server -XX:+UseParallelGC

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

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




Build Log:
[...truncated 8669 lines...]
[junit4:junit4] Suite: org.apache.solr.cloud.RecoveryZkTest
[junit4:junit4]   2> 3 T1315 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4:junit4]   2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-RecoveryZkTest-1348840027575
[junit4:junit4]   2> 3 T1315 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4]   2> 5 T1316 oazs.ZooKeeperServer.setTickTime tickTime set to 1000
[junit4:junit4]   2> 6 T1316 oazs.NIOServerCnxn$Factory.<init> binding to port 0.0.0.0/0.0.0.0:0
[junit4:junit4]   2> 9 T1316 oazsp.FileTxnSnapLog.save Snapshotting: 0
[junit4:junit4]   2> 104 T1315 oasc.ZkTestServer.run start zk server on port:35967
[junit4:junit4]   2> 105 T1315 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:35967 sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@1bd65a2
[junit4:junit4]   2> 106 T1321 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:35967
[junit4:junit4]   2> 106 T1315 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 107 T1321 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:35967, initiating session
[junit4:junit4]   2> 107 T1317 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:46032
[junit4:junit4]   2> 107 T1317 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:46032
[junit4:junit4]   2> 108 T1319 oazsp.FileTxnLog.append Creating new log file: log.1
[junit4:junit4]   2> 139 T1321 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:35967, sessionid = 0x13a0d2175bd0000, negotiated timeout = 10000
[junit4:junit4]   2> 139 T1319 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a0d2175bd0000 with negotiated timeout 10000 for client /127.0.0.1:46032
[junit4:junit4]   2> 139 T1322 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1bd65a2 name:ZooKeeperConnection Watcher:127.0.0.1:35967 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 140 T1315 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 141 T1315 oascc.SolrZkClient.makePath makePath: /solr
[junit4:junit4]   2> 144 T1320 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13a0d2175bd0000
[junit4:junit4]   2> 145 T1322 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 146 T1317 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:46032 which had sessionid 0x13a0d2175bd0000
[junit4:junit4]   2> 145 T1315 oaz.ZooKeeper.close Session: 0x13a0d2175bd0000 closed
[junit4:junit4]   2> 146 T1315 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:35967/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@1c322ec
[junit4:junit4]   2> 147 T1323 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:35967
[junit4:junit4]   2> 147 T1315 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 148 T1323 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:35967, initiating session
[junit4:junit4]   2> 148 T1317 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:46033
[junit4:junit4]   2> 149 T1317 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:46033
[junit4:junit4]   2> 149 T1319 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a0d2175bd0001 with negotiated timeout 10000 for client /127.0.0.1:46033
[junit4:junit4]   2> 149 T1323 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:35967, sessionid = 0x13a0d2175bd0001, negotiated timeout = 10000
[junit4:junit4]   2> 150 T1324 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1c322ec name:ZooKeeperConnection Watcher:127.0.0.1:35967/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 150 T1315 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 151 T1315 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4:junit4]   2> 154 T1315 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4:junit4]   2> 160 T1315 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4:junit4]   2> 167 T1315 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4:junit4]   2> 177 T1315 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 178 T1315 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 696 T1315 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4:junit4]   2> 697 T1315 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4:junit4]   2> 1170 T1315 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 1171 T1315 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 1175 T1315 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4:junit4]   2> 1176 T1315 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
[junit4:junit4]   2> 1179 T1315 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4:junit4]   2> 1179 T1315 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
[junit4:junit4]   2> 1182 T1315 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4:junit4]   2> 1182 T1315 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
[junit4:junit4]   2> 1185 T1315 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 1185 T1315 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 1188 T1315 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 1189 T1315 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 1191 T1315 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 1192 T1315 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 1205 T1315 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4:junit4]   2> 1206 T1315 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
[junit4:junit4]   2> 1210 T1320 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13a0d2175bd0001
[junit4:junit4]   2> 1211 T1324 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 1211 T1317 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:46033 which had sessionid 0x13a0d2175bd0001
[junit4:junit4]   2> 1211 T1315 oaz.ZooKeeper.close Session: 0x13a0d2175bd0001 closed
[junit4:junit4]   2> 1270 T1315 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 1275 T1315 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:51795
[junit4:junit4]   2> 1275 T1315 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 1276 T1315 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1348840028784
[junit4:junit4]   2> 1276 T1315 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1348840028784/'
[junit4:junit4]   2> 1295 T1315 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 1296 T1315 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 1296 T1315 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1348840028784
[junit4:junit4]   2> 1297 T1315 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1348840028784/solr.xml
[junit4:junit4]   2> 1297 T1315 oasc.CoreContainer.<init> New CoreContainer 19112082
[junit4:junit4]   2> 1298 T1315 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1348840028784/'
[junit4:junit4]   2> 1298 T1315 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1348840028784/'
[junit4:junit4]   2> 1312 T1315 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 1318 T1315 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:35967/solr
[junit4:junit4]   2> 1319 T1315 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:35967/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@175c3ea
[junit4:junit4]   2> 1319 T1334 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:35967
[junit4:junit4]   2> 1319 T1315 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 1320 T1334 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:35967, initiating session
[junit4:junit4]   2> 1320 T1317 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:46035
[junit4:junit4]   2> 1320 T1317 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:46035
[junit4:junit4]   2> 1337 T1319 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a0d2175bd0002 with negotiated timeout 5000 for client /127.0.0.1:46035
[junit4:junit4]   2> 1337 T1334 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:35967, sessionid = 0x13a0d2175bd0002, negotiated timeout = 5000
[junit4:junit4]   2> 1337 T1335 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@175c3ea name:ZooKeeperConnection Watcher:127.0.0.1:35967/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 1338 T1315 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 1357 T1320 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a0d2175bd0002 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1377 T1315 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4:junit4]   2> 1397 T1315 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:51795_solr
[junit4:junit4]   2> 1398 T1320 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a0d2175bd0002 type:delete cxid:0x7 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:51795_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:51795_solr
[junit4:junit4]   2> 1417 T1315 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:51795_solr
[junit4:junit4]   2> 1438 T1315 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 1438 T1315 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 1439 T1315 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 1439 T1315 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 1440 T1315 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 1441 T1315 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 1441 T1315 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 1442 T1315 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 1442 T1315 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 1443 T1315 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 1449 T1315 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4:junit4]   2> 1507 T1320 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a0d2175bd0002 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> 1517 T1315 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4]   2> 1537 T1315 oasc.Overseer.start Overseer (id=88397580047548418-127.0.0.1:51795_solr-n_0000000000) starting
[junit4:junit4]   2> 1538 T1320 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a0d2175bd0002 type:create cxid:0x1a zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1557 T1320 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a0d2175bd0002 type:create cxid:0x1b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1577 T1320 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a0d2175bd0002 type:create cxid:0x1c zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1597 T1320 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a0d2175bd0002 type:create cxid:0x1d zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1599 T1337 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
[junit4:junit4]   2> 1599 T1315 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4:junit4]   2> 1602 T1315 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 1604 T1336 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4]   2> 1608 T1315 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1348840028784/collection1
[junit4:junit4]   2> 1609 T1315 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection
[junit4:junit4]   2> 1610 T1315 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 1610 T1315 oasc.ZkController.readConfigName Load collection config from:/collections/control_collection
[junit4:junit4]   2> 1612 T1315 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1348840028784/collection1/'
[junit4:junit4]   2> 1613 T1315 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-controljetty-1348840028784/collection1/lib/README' to classloader
[junit4:junit4]   2> 1614 T1315 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-controljetty-1348840028784/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 1654 T1315 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 1691 T1315 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 1692 T1315 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 1695 T1315 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 2014 T1315 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 2019 T1315 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 2022 T1315 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 2028 T1315 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 2030 T1315 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 2032 T1315 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 2033 T1315 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 2034 T1315 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-controljetty-1348840028784/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1348840027575/control/data/
[junit4:junit4]   2> 2034 T1315 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d5efc
[junit4:junit4]   2> 2041 T1315 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1348840027575/control/data/index/
[junit4:junit4]   2> 2041 T1315 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1348840027575/control/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 2042 T1315 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-1348840027575/control/data/index forceNew:false
[junit4:junit4]   2> 2067 T1315 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-1348840027575/control/data/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 2068 T1315 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 2068 T1315 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 2070 T1315 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 2070 T1315 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 2070 T1315 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 2071 T1315 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 2071 T1315 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 2072 T1315 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 2072 T1315 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 2073 T1315 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 2073 T1315 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 2074 T1315 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 2074 T1315 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 2074 T1315 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 2075 T1315 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 2075 T1315 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 2075 T1315 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 2076 T1315 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 2076 T1315 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2076 T1315 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2077 T1315 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2077 T1315 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2077 T1315 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2078 T1315 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2078 T1315 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2079 T1315 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 2079 T1315 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 2081 T1315 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 2083 T1315 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 2084 T1315 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SCHEMA.XML, OPEN-EXCHANGE-RATES.JSON, OLD_SYNONYMS.TXT, STOPWORDS.TXT, MAPPING-ISOLATIN1ACCENT.TXT, PROTWORDS.TXT, CURRENCY.XML, SYNONYMS.TXT]
[junit4:junit4]   2> 2086 T1315 oass.SolrIndexSearcher.<init> Opening Searcher@9f4b1c main
[junit4:junit4]   2> 2086 T1315 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 2087 T1315 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 2087 T1315 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 2116 T1315 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 2142 T1338 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@9f4b1c main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 2155 T1320 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a0d2175bd0002 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> 2158 T1315 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 2159 T1315 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:51795/solr shardId:control_shard
[junit4:junit4]   2> 2160 T1315 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/control_shard/election
[junit4:junit4]   2> 2162 T1320 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a0d2175bd0002 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> 2163 T1315 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 2163 T1320 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a0d2175bd0002 type:create cxid:0x63 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2607 T1336 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2608 T1320 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a0d2175bd0002 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> 2746 T1335 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3165 T1315 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4]   2> 3165 T1315 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 3166 T1315 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:51795/solr/collection1/
[junit4:junit4]   2> 3166 T1315 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4:junit4]   2> 3166 T1315 oasc.SyncStrategy.syncToMe http://127.0.0.1:51795/solr/collection1/ has no replicas
[junit4:junit4]   2> 3167 T1315 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:51795/solr/collection1/
[junit4:junit4]   2> 3167 T1315 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/control_shard
[junit4:junit4]   2> 3207 T1320 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a0d2175bd0002 type:create cxid:0x88 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3289 T1336 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3489 T1335 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3498 T1315 oasc.ZkController.register We are http://127.0.0.1:51795/solr/collection1/ and leader is http://127.0.0.1:51795/solr/collection1/
[junit4:junit4]   2> 3499 T1315 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:51795/solr
[junit4:junit4]   2> 3499 T1315 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4]   2> 3508 T1315 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3509 T1315 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0
[junit4:junit4]   2> 3509 T1315 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 3510 T1315 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 3565 T1315 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 3568 T1315 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:41901
[junit4:junit4]   2> 3569 T1315 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 3569 T1315 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1348840031087
[junit4:junit4]   2> 3570 T1315 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1348840031087/'
[junit4:junit4]   2> 3585 T1315 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 3586 T1315 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 3586 T1315 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1348840031087
[junit4:junit4]   2> 3587 T1315 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1348840031087/solr.xml
[junit4:junit4]   2> 3587 T1315 oasc.CoreContainer.<init> New CoreContainer 31414958
[junit4:junit4]   2> 3588 T1315 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1348840031087/'
[junit4:junit4]   2> 3588 T1315 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1348840031087/'
[junit4:junit4]   2> 3606 T1315 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 3612 T1315 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:35967/solr
[junit4:junit4]   2> 3613 T1315 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:35967/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@d82f29
[junit4:junit4]   2> 3614 T1348 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:35967
[junit4:junit4]   2> 3614 T1315 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 3614 T1348 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:35967, initiating session
[junit4:junit4]   2> 3614 T1317 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:46036
[junit4:junit4]   2> 3614 T1317 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:46036
[junit4:junit4]   2> 3627 T1319 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a0d2175bd0003 with negotiated timeout 5000 for client /127.0.0.1:46036
[junit4:junit4]   2> 3627 T1348 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:35967, sessionid = 0x13a0d2175bd0003, negotiated timeout = 5000
[junit4:junit4]   2> 3627 T1349 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@d82f29 name:ZooKeeperConnection Watcher:127.0.0.1:35967/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 3627 T1315 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 3629 T1320 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a0d2175bd0003 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3629 T1320 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a0d2175bd0003 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3631 T1315 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41901_solr
[junit4:junit4]   2> 3631 T1320 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a0d2175bd0003 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:41901_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:41901_solr
[junit4:junit4]   2> 3632 T1315 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:41901_solr
[junit4:junit4]   2> 3634 T1335 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 3634 T1315 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 3635 T1315 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 3635 T1315 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 3635 T1315 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 3635 T1315 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 3636 T1315 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 3636 T1315 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 3636 T1315 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 3637 T1315 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 3637 T1315 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 3640 T1315 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 3643 T1315 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1348840031087/collection1
[junit4:junit4]   2> 3643 T1315 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 3644 T1315 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 3644 T1315 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 3645 T1315 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1348840031087/collection1/'
[junit4:junit4]   2> 3645 T1315 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-jetty1-1348840031087/collection1/lib/README' to classloader
[junit4:junit4]   2> 3645 T1315 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-jetty1-1348840031087/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 3667 T1315 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 3719 T1315 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 3721 T1315 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 3723 T1315 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 3972 T1315 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 3977 T1315 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 3980 T1315 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 3990 T1315 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 3992 T1336 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3992 T1315 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 3999 T1335 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3999 T1349 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3999 T1315 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 4000 T1315 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 4001 T1315 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-jetty1-1348840031087/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1348840027575/jetty1/
[junit4:junit4]   2> 4002 T1315 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d5efc
[junit4:junit4]   2> 4002 T1315 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1348840027575/jetty1/index/
[junit4:junit4]   2> 4003 T1315 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1348840027575/jetty1/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 4003 T1315 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-1348840027575/jetty1/index forceNew:false
[junit4:junit4]   2> 4009 T1315 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-1348840027575/jetty1/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 4010 T1315 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 4011 T1315 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 4013 T1315 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 4013 T1315 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 4014 T1315 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 4014 T1315 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 4015 T1315 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 4016 T1315 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 4016 T1315 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 4017 T1315 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 4017 T1315 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 4017 T1315 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 4018 T1315 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 4018 T1315 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 4018 T1315 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 4019 T1315 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 4019 T1315 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 4019 T1315 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 4020 T1315 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4020 T1315 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4021 T1315 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4021 T1315 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4021 T1315 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4022 T1315 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4022 T1315 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4022 T1315 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 4023 T1315 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 4026 T1315 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 4028 T1315 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 4028 T1315 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SCHEMA.XML, OPEN-EXCHANGE-RATES.JSON, OLD_SYNONYMS.TXT, STOPWORDS.TXT, MAPPING-ISOLATIN1ACCENT.TXT, PROTWORDS.TXT, CURRENCY.XML, SYNONYMS.TXT]
[junit4:junit4]   2> 4030 T1315 oass.SolrIndexSearcher.<init> Opening Searcher@19a1027 main
[junit4:junit4]   2> 4031 T1315 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 4031 T1315 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 4031 T1315 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 4059 T1315 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 4103 T1350 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@19a1027 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 4502 T1336 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 4547 T1335 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4547 T1349 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4607 T1315 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 4608 T1315 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:41901/solr shardId:shard1
[junit4:junit4]   2> 4608 T1315 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election
[junit4:junit4]   2> 4611 T1320 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a0d2175bd0003 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> 4611 T1315 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 4612 T1320 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a0d2175bd0003 type:create cxid:0x44 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4613 T1315 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4]   2> 4613 T1315 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 4613 T1315 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:41901/solr/collection1/
[junit4:junit4]   2> 4613 T1315 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4:junit4]   2> 4614 T1315 oasc.SyncStrategy.syncToMe http://127.0.0.1:41901/solr/collection1/ has no replicas
[junit4:junit4]   2> 4614 T1315 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:41901/solr/collection1/
[junit4:junit4]   2> 4614 T1315 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4:junit4]   2> 4618 T1320 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a0d2175bd0003 type:create cxid:0x4e zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5048 T1336 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 5147 T1335 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5147 T1349 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5178 T1315 oasc.ZkController.register We are http://127.0.0.1:41901/solr/collection1/ and leader is http://127.0.0.1:41901/solr/collection1/
[junit4:junit4]   2> 5178 T1315 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:41901/solr
[junit4:junit4]   2> 5179 T1315 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4]   2> 5207 T1315 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 5208 T1315 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0
[junit4:junit4]   2> 5208 T1315 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 5209 T1315 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 5264 T1315 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 5265 T1315 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:57321
[junit4:junit4]   2> 5266 T1315 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 5266 T1315 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1348840032784
[junit4:junit4]   2> 5267 T1315 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1348840032784/'
[junit4:junit4]   2> 5277 T1315 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 5277 T1315 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 5277 T1315 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1348840032784
[junit4:junit4]   2> 5278 T1315 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1348840032784/solr.xml
[junit4:junit4]   2> 5278 T1315 oasc.CoreContainer.<init> New CoreContainer 23369040
[junit4:junit4]   2> 5278 T1315 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1348840032784/'
[junit4:junit4]   2> 5279 T1315 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1348840032784/'
[junit4:junit4]   2> 5289 T1315 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 5295 T1315 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:35967/solr
[junit4:junit4]   2> 5296 T1315 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:35967/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@17f7815
[junit4:junit4]   2> 5296 T1360 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:35967
[junit4:junit4]   2> 5296 T1315 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 5297 T1360 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:35967, initiating session
[junit4:junit4]   2> 5297 T1317 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:46038
[junit4:junit4]   2> 5297 T1317 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:46038
[junit4:junit4]   2> 5307 T1360 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:35967, sessionid = 0x13a0d2175bd0004, negotiated timeout = 5000
[junit4:junit4]   2> 5307 T1319 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a0d2175bd0004 with negotiated timeout 5000 for client /127.0.0.1:46038
[junit4:junit4]   2> 5307 T1361 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@17f7815 name:ZooKeeperConnection Watcher:127.0.0.1:35967/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 5308 T1315 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 5308 T1320 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a0d2175bd0004 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5309 T1320 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a0d2175bd0004 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5310 T1315 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:57321_solr
[junit4:junit4]   2> 5310 T1320 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13a0d2175bd0004 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:57321_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:57321_solr
[junit4:junit4]   2> 5310 T1315 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:57321_solr
[junit4:junit4]   2> 5311 T1349 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 5311 T1335 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 5312 T1315 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 5312 T1315 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 5312 T1315 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 5313 T1315 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 5313 T1315 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 5314 T1315 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 5314 T1315 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 5314 T1315 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 5315 T1315 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 5315 T1315 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 5326 T1315 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 5329 T1315 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1348840032784/collection1
[junit4:junit4]   2> 5329 T1315 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 5330 T1315 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 5330 T1315 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 5331 T1315 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1348840032784/collection1/'
[junit4:junit4]   2> 5332 T1315 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-jetty2-1348840032784/collection1/lib/README' to classloader
[junit4:junit4]   2> 5333 T1315 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-jetty2-1348840032784/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 5353 T1315 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 5384 T1315 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 5385 T1315 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 5388 T1315 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 5655 T1315 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 5660 T1315 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 5662 T1315 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 5669 T1315 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 5671 T1315 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 5673 T1315 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 5674 T1315 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 5675 T1315 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-jetty2-1348840032784/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1348840027575/jetty2/
[junit4:junit4]   2> 5675 T1315 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d5efc
[junit4:junit4]   2> 5676 T1315 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1348840027575/jetty2/index/
[junit4:junit4]   2> 5676 T1315 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1348840027575/jetty2/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 5677 T1315 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.RecoveryZkTest-1348840027575/jetty2/index forceNew:false
[junit4:junit4]   2> 5707 T1336 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 5746 T1361 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5746 T1349 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5746 T1335 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 5910 T1315 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-1348840027575/jetty2/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 5910 T1315 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 5911 T1315 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 5912 T1315 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 5912 T1315 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 5912 T1315 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 5913 T1315 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 5913 T1315 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 5914 T1315 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 5914 T1315 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 5914 T1315 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 5915 T1315 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 5915 T1315 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 5916 T1315 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 5916 T1315 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 5916 T1315 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 5917 T1315 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 5917 T1315 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 5917 T1315 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 5918 T1315 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5918 T1315 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5918 T1315 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5919 T1315 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5919 T1315 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5919 T1315 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5920 T1315 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5920 T1315 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 5921 T1315 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 5923 T1315 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 5924 T1315 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 5925 T1315 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SCHEMA.XML, OPEN-EXCHANGE-RATES.JSON, OLD_SYNONYMS.TXT, STOPWORDS.TXT, MAPPING-ISOLATIN1ACCENT.TXT, PROTWORDS.TXT, CURRENCY.XML, SYNONYMS.TXT]
[junit4:junit4]   2> 5927 T1315 oass.SolrIndexSearcher.<init> Opening Searcher@ea8e2f main
[junit4:junit4]   2> 5927 T1315 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 5928 T1315 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 5928 T1315 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 6017 T1315 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 6528 T1362 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@ea8e2f main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 6769 T1336 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 6778 T1335 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 6778 T1349 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 6778 T1361 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 7031 T1315 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 7032 T1315 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:57321/solr shardId:shard1
[junit4:junit4]   2> 7036 T1315 oasc.ZkController.register We are http://127.0.0.1:57321/solr/collection1/ and leader is http://127.0.0.1:41901/solr/collection1/
[junit4:junit4]   2> 7036 T1315 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:57321/solr
[junit4:junit4]   2> 7037 T1315 oasc.ZkController.checkRecovery Core needs to recover:collection1
[junit4:junit4]   2> 7037 T1315 oasu.DefaultSolrCoreState.doRecovery Running recovery - first canceling any ongoing recovery
[junit4:junit4]   2> 7042 T1315 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> ASYNC  NEW_CORE C56 name=collection1 org.apache.solr.core.SolrCore@97f3af url=http://127.0.0.1:57321/solr/collection1 node=127.0.0.1:57321_solr
[junit4:junit4]   2> 7043 T1363 C56 P57321 oasc.RecoveryStrategy.run Starting recovery process.  core=collection1 recoveringAfterStartup=true
[junit4:junit4]   2> 7042 T1315 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0
[junit4:junit4]   2> 7043 T1363 C56 P57321 oasc.RecoveryStrategy.doRecovery ###### startupVersions=[]
[junit4:junit4]   2> 7043 T1315 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 7044 T1315 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 7044 T1363 C56 P57321 oasc.RecoveryStrategy.doRecovery Attempting to PeerSync from http://127.0.0.1:41901/solr/collection1/ core=collection1 - recoveringAfterStartup=true
[junit4:junit4]   2> 7048 T1363 C56 P57321 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&connTimeout=30000&socketTimeout=30000&retry=false
[junit4:junit4]   2> 7048 T1315 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:35967/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@ed5c01
[junit4:junit4]   2> 7049 T1364 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:35967
[junit4:junit4]   2> 7049 T1315 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 7050 T1364 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:35967, initiating session
[junit4:junit4]   2> 7050 T1317 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:46042
[junit4:junit4]   2> 7050 T1317 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:46042
[junit4:junit4]   2> 7053 T1363 C56 P57321 oasu.PeerSync.sync PeerSync: core=collection1 url=http://127.0.0.1:57321/solr START replicas=[http://127.0.0.1:41901/solr/collection1/] nUpdates=100
[junit4:junit4]   2> 7054 T1363 C56 P57321 oasu.PeerSync.sync WARNING no frame of reference to tell of we've missed updates
[junit4:junit4]   2> 7054 T1363 C56 P57321 oasc.RecoveryStrategy.doRecovery PeerSync Recovery was not successful - trying replication. core=collection1
[junit4:junit4]   2> 7054 T1363 C56 P57321 oasc.RecoveryStrategy.doRecovery Starting Replication Recovery. core=collection1
[junit4:junit4]   2> 7054 T1363 C56 P57321 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> ASYNC  NEW_CORE C57 name=collection1 org.apache.solr.core.SolrCore@8a9565 url=http://127.0.0.1:41901/solr/collection1 node=127.0.0.1:41901_solr
[junit4:junit4]   2> 7060 T1341 C57 P41901 REQ /get {getVersions=100&distrib=false&qt=/get&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7066 T1319 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a0d2175bd0005 with negotiated timeout 10000 for client /127.0.0.1:46042
[junit4:junit4]   2> 7066 T1364 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:35967, sessionid = 0x13a0d2175bd0005, negotiated timeout = 10000
[junit4:junit4]   2> 7066 T1365 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@ed5c01 name:ZooKeeperConnection Watcher:127.0.0.1:35967/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 7067 T1315 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 7067 T1315 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 7070 T1315 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:true cause connection loss:true
[junit4:junit4]   2> 7071 T1315 oascsi.HttpClientUtil.createClient Creating new http client, config:
[junit4:junit4]   2> 7073 T1315 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> ASYNC  NEW_CORE C58 name=collection1 org.apache.solr.core.SolrCore@57d12d url=http://127.0.0.1:51795/solr/collection1 node=127.0.0.1:51795_solr
[junit4:junit4]   2> 7091 T1328 C58 P51795 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-1348840027575/control/data/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 7091 T1328 C58 P51795 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 7108 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[1 (1414361288185741312)]} 0 19
[junit4:junit4]   2> 7108 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10001 (1414361288183644160)]} 0 20
[junit4:junit4]   2> 7110 T1367 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:35967/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@5b239f
[junit4:junit4]   2> 7110 T1369 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:35967
[junit4:junit4]   2> 7110 T1367 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 7111 T1369 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:35967, initiating session
[junit4:junit4]   2> 7111 T1317 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:46048
[junit4:junit4]   2> 7111 T1317 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:46048
[junit4:junit4]   2> 7113 T1319 oazs.NIOServerCnxn.finishSessionInit Established session 0x13a0d2175bd0006 with negotiated timeout 10000 for client /127.0.0.1:46048
[junit4:junit4]   2> 7113 T1369 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:35967, sessionid = 0x13a0d2175bd0006, negotiated timeout = 10000
[junit4:junit4]   2> 7113 T1370 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@5b239f name:ZooKeeperConnection Watcher:127.0.0.1:35967/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 7113 T1367 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 7114 T1367 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 7119 T1344 C57 P41901 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-1348840027575/jetty1/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 7120 T1344 C57 P41901 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 7122 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10001 (1414361288214052864)]} 0 5
[junit4:junit4]   2> 7122 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[1 (1414361288214052865)]} 0 5
[junit4:junit4]   2> 7132 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10002 (1414361288225587200)]} 0 5
[junit4:junit4]   2> 7133 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[2 (1414361288225587201)]} 0 6
[junit4:junit4]   2> 7136 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10002 (1414361288233975808)]} 0 1
[junit4:junit4]   2> 7137 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[2 (1414361288233975809)]} 0 1
[junit4:junit4]   2> 7140 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10001 (-1414361288237121537)]} 0 1
[junit4:junit4]   2> 7140 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[1 (-1414361288237121536)]} 0 1
[junit4:junit4]   2> 7143 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[1 (-1414361288241315840)]} 0 0
[junit4:junit4]   2> 7144 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10001 (-1414361288242364416)]} 0 0
[junit4:junit4]   2> 7147 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[3 (1414361288245510145)]} 0 0
[junit4:junit4]   2> 7147 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10003 (1414361288245510144)]} 0 0
[junit4:junit4]   2> 7151 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[3 (1414361288248655872)]} 0 1
[junit4:junit4]   2> 7151 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10003 (1414361288248655873)]} 0 1
[junit4:junit4]   2> 7156 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[4 (1414361288253898752)]} 0 1
[junit4:junit4]   2> 7156 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10004 (1414361288253898753)]} 0 1
[junit4:junit4]   2> 7159 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[4 (1414361288258093056)]} 0 0
[junit4:junit4]   2> 7160 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10004 (1414361288259141632)]} 0 0
[junit4:junit4]   2> 7163 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[2 (-1414361288262287360)]} 0 0
[junit4:junit4]   2> 7163 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10002 (-1414361288262287361)]} 0 0
[junit4:junit4]   2> 7166 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[2 (-1414361288265433088)]} 0 0
[junit4:junit4]   2> 7166 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10002 (-1414361288265433089)]} 0 0
[junit4:junit4]   2> 7169 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10005 (1414361288267530240)]} 0 1
[junit4:junit4]   2> 7170 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[5 (1414361288268578816)]} 0 1
[junit4:junit4]   2> 7172 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10005 (1414361288270675968)]} 0 1
[junit4:junit4]   2> 7174 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10006 (1414361288273821696)]} 0 0
[junit4:junit4]   2> 7177 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10006 (1414361288275918848)]} 0 1
[junit4:junit4]   2> 7180 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10007 (1414361288279064576)]} 0 1
[junit4:junit4]   2> 7181 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[5 (1414361288271724544)]} 0 9
[junit4:junit4]   2> 7182 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10007 (1414361288282210304)]} 0 0
[junit4:junit4]   2> 7183 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[6 (1414361288283258880)]} 0 0
[junit4:junit4]   2> 7184 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10008 (1414361288284307456)]} 0 0
[junit4:junit4]   2> 7186 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[6 (1414361288285356032)]} 0 1
[junit4:junit4]   2> 7187 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10008 (1414361288286404608)]} 0 1
[junit4:junit4]   2> 7188 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[7 (1414361288288501760)]} 0 0
[junit4:junit4]   2> 7188 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10004 (-1414361288288501761)]} 0 0
[junit4:junit4]   2> 7190 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[7 (1414361288290598912)]} 0 0
[junit4:junit4]   2> 7190 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10004 (-1414361288290598913)]} 0 0
[junit4:junit4]   2> 7192 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[8 (1414361288292696064)]} 0 0
[junit4:junit4]   2> 7193 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10009 (1414361288292696065)]} 0 1
[junit4:junit4]   2> 7195 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[8 (1414361288294793216)]} 0 1
[junit4:junit4]   2> 7195 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10009 (1414361288294793217)]} 0 1
[junit4:junit4]   2> 7197 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10006 (-1414361288297938945)]} 0 0
[junit4:junit4]   2> 7197 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[4 (-1414361288297938944)]} 0 0
[junit4:junit4]   2> 7199 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10006 (-1414361288300036096)]} 0 0
[junit4:junit4]   2> 7199 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[4 (-1414361288300036097)]} 0 0
[junit4:junit4]   2> 7201 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10010 (1414361288302133248)]} 0 0
[junit4:junit4]   2> 7204 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10010 (1414361288305278976)]} 0 0
[junit4:junit4]   2> 7206 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[9 (1414361288302133249)]} 0 5
[junit4:junit4]   2> 7206 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10010 (-1414361288307376128)]} 0 0
[junit4:junit4]   2> 7208 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[9 (1414361288309473280)]} 0 0
[junit4:junit4]   2> 7208 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10010 (-1414361288309473281)]} 0 0
[junit4:junit4]   2> 7212 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[6 (-1414361288313667584)]} 0 1
[junit4:junit4]   2> 7212 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10011 (1414361288312619008)]} 0 1
[junit4:junit4]   2> 7219 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[6 (-1414361288321007616)]} 0 0
[junit4:junit4]   2> 7231 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10 (1414361288325201920)]} 0 9
[junit4:junit4]   2> 7235 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10 (1414361288336736256)]} 0 1
[junit4:junit4]   2> 7235 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10011 (1414361288321007617)]} 0 16
[junit4:junit4]   2> 7238 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10 (-1414361288340930560)]} 0 0
[junit4:junit4]   2> 7238 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10012 (1414361288340930561)]} 0 0
[junit4:junit4]   2> 7240 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10 (-1414361288343027712)]} 0 0
[junit4:junit4]   2> 7241 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10012 (1414361288343027713)]} 0 1
[junit4:junit4]   2> 7243 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[11 (1414361288346173440)]} 0 0
[junit4:junit4]   2> 7244 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10013 (1414361288346173441)]} 0 1
[junit4:junit4]   2> 7246 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10013 (1414361288349319168)]} 0 0
[junit4:junit4]   2> 7247 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[11 (1414361288350367744)]} 0 0
[junit4:junit4]   2> 7248 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10014 (1414361288351416320)]} 0 0
[junit4:junit4]   2> 7249 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[12 (1414361288352464896)]} 0 0
[junit4:junit4]   2> 7251 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10014 (1414361288353513472)]} 0 1
[junit4:junit4]   2> 7251 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[12 (1414361288354562048)]} 0 0
[junit4:junit4]   2> 7253 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10015 (1414361288356659200)]} 0 0
[junit4:junit4]   2> 7254 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[13 (1414361288356659201)]} 0 1
[junit4:junit4]   2> 7255 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10015 (1414361288358756352)]} 0 0
[junit4:junit4]   2> 7256 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[13 (1414361288359804928)]} 0 1
[junit4:junit4]   2> 7257 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10011 (-1414361288360853504)]} 0 0
[junit4:junit4]   2> 7258 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[14 (1414361288361902080)]} 0 0
[junit4:junit4]   2> 7259 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10011 (-1414361288362950656)]} 0 0
[junit4:junit4]   2> 7261 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[14 (1414361288363999232)]} 0 1
[junit4:junit4]   2> 7263 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10016 (1414361288367144960)]} 0 0
[junit4:junit4]   2> 7263 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[15 (1414361288367144961)]} 0 0
[junit4:junit4]   2> 7268 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[15 (1414361288370290689)]} 0 2
[junit4:junit4]   2> 7271 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[11 (-1414361288375533568)]} 0 0
[junit4:junit4]   2> 7278 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[11 (-1414361288382873600)]} 0 1
[junit4:junit4]   2> 7279 T1336 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 7281 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[16 (1414361288384970752)]} 0 1
[junit4:junit4]   2> 7285 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[16 (1414361288389165056)]} 0 1
[junit4:junit4]   2> 7285 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10016 (1414361288370290688)]} 0 19
[junit4:junit4]   2> 7287 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[12 (-1414361288392310784)]} 0 0
[junit4:junit4]   2> 7287 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10012 (-1414361288392310785)]} 0 0
[junit4:junit4]   2> 7290 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10012 (-1414361288395456513)]} 0 0
[junit4:junit4]   2> 7290 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[12 (-1414361288395456512)]} 0 0
[junit4:junit4]   2> 7293 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[17 (1414361288398602241)]} 0 0
[junit4:junit4]   2> 7293 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10017 (1414361288398602240)]} 0 0
[junit4:junit4]   2> 7296 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[17 (1414361288401747969)]} 0 0
[junit4:junit4]   2> 7296 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10017 (1414361288401747968)]} 0 0
[junit4:junit4]   2> 7299 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[14 (-1414361288403845120)]} 0 1
[junit4:junit4]   2> 7299 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10014 (-1414361288403845121)]} 0 1
[junit4:junit4]   2> 7301 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10014 (-1414361288406990848)]} 0 0
[junit4:junit4]   2> 7303 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[14 (-1414361288408039424)]} 0 1
[junit4:junit4]   2> 7311 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10018 (1414361288409088000)]} 0 8
[junit4:junit4]   2> 7313 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[18 (1414361288419573760)]} 0 1
[junit4:junit4]   2> 7315 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10018 (1414361288421670912)]} 0 0
[junit4:junit4]   2> 7317 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[18 (1414361288423768064)]} 0 1
[junit4:junit4]   2> 7318 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10019 (1414361288424816640)]} 0 1
[junit4:junit4]   2> 7321 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10019 (1414361288426913792)]} 0 1
[junit4:junit4]   2> 7322 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[19 (1414361288425865216)]} 0 3
[junit4:junit4]   2> 7323 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10018 (-1414361288430059520)]} 0 0
[junit4:junit4]   2> 7325 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[19 (1414361288431108096)]} 0 1
[junit4:junit4]   2> 7326 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10018 (-1414361288433205248)]} 0 1
[junit4:junit4]   2> 7329 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10020 (1414361288435302400)]} 0 1
[junit4:junit4]   2> 7332 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10020 (1414361288438448128)]} 0 1
[junit4:junit4]   2> 7329 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[18 (-1414361288436350976)]} 0 0
[junit4:junit4]   2> 7335 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10021 (1414361288441593856)]} 0 1
[junit4:junit4]   2> 7335 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[18 (-1414361288442642432)]} 0 1
[junit4:junit4]   2> 7336 T1370 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 7336 T1335 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 7336 T1365 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 7337 T1349 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 7336 T1361 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 7344 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[20 (1414361288444739584)]} 0 7
[junit4:junit4]   2>  C56_STATE=coll:collection1 core:collection1 props:{collection=collection1, state=recovering, core=collection1, node_name=127.0.0.1:57321_solr, roles=null, base_url=http://127.0.0.1:57321/solr, shard=shard1}
[junit4:junit4]   2> 7357 T1353 C56 P57321 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-1348840027575/jetty2/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 7358 T1353 C56 P57321 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 7360 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7360 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=6 
[junit4:junit4]   2> 7361 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10021 (1414361288453128192)]} 0 24
[junit4:junit4]   2> 7361 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[20 (1414361288455225344)]} 0 14
[junit4:junit4]   2> 7363 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[21 (1414361288472002561)]} 0 0
[junit4:junit4]   2> 7363 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10022 (1414361288472002560)]} 0 1
[junit4:junit4]   2> 7368 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7368 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7370 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10022 (1414361288475148289)]} 0 5
[junit4:junit4]   2> 7370 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[21 (1414361288475148288)]} 0 5
[junit4:junit4]   2> 7373 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[22 (1414361288481439744)]} 0 1
[junit4:junit4]   2> 7373 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10023 (1414361288481439745)]} 0 1
[junit4:junit4]   2> 7378 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7378 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7379 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[22 (1414361288484585472)]} 0 4
[junit4:junit4]   2> 7379 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10023 (1414361288484585473)]} 0 4
[junit4:junit4]   2> 7382 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10024 (1414361288491925504)]} 0 0
[junit4:junit4]   2> 7382 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[23 (1414361288491925505)]} 0 0
[junit4:junit4]   2> 7387 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7388 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10024 (1414361288495071232)]} 0 4
[junit4:junit4]   2> 7388 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7389 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[23 (1414361288496119808)]} 0 3
[junit4:junit4]   2> 7391 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10025 (1414361288500314112)]} 0 1
[junit4:junit4]   2> 7391 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[24 (1414361288501362688)]} 0 0
[junit4:junit4]   2> 7396 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7397 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[24 (1414361288503459840)]} 0 4
[junit4:junit4]   2> 7400 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[25 (1414361288510799872)]} 0 0
[junit4:junit4]   2> 7409 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=12 
[junit4:junit4]   2> 7410 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10025 (1414361288505556992)]} 0 15
[junit4:junit4]   2> 7413 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7414 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[25 (1414361288513945600)]} 0 11
[junit4:junit4]   2> 7415 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10025 (-1414361288526528512)]} 0 0
[junit4:junit4]   2> 7416 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[25 (-1414361288527577088)]} 0 0
[junit4:junit4]   2> 7422 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7423 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10025 (-1414361288530722817)]} 0 4
[junit4:junit4]   2> 7427 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10026 (1414361288537014272)]} 0 2
[junit4:junit4]   2> 7428 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7431 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[25 (-1414361288530722816)]} 0 12
[junit4:junit4]   2> 7432 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7433 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10026 (1414361288541208576)]} 0 4
[junit4:junit4]   2> 7435 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[26 (1414361288546451456)]} 0 1
[junit4:junit4]   2> 7436 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10027 (1414361288547500032)]} 0 1
[junit4:junit4]   2> 7443 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7443 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7444 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10027 (1414361288551694336)]} 0 5
[junit4:junit4]   2> 7444 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[26 (1414361288552742912)]} 0 4
[junit4:junit4]   2> 7447 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[27 (1414361288559034368)]} 0 1
[junit4:junit4]   2> 7448 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10027 (-1414361288561131520)]} 0 0
[junit4:junit4]   2> 7453 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7454 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[27 (1414361288562180096)]} 0 5
[junit4:junit4]   2> 7454 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7460 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10027 (-1414361288563228672)]} 0 10
[junit4:junit4]   2> 7461 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[27 (-1414361288574763008)]} 0 0
[junit4:junit4]   2> 7462 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10028 (1414361288575811584)]} 0 0
[junit4:junit4]   2> 7465 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7465 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[27 (-1414361288576860160)]} 0 2
[junit4:junit4]   2> 7468 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7468 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[28 (1414361288582103040)]} 0 1
[junit4:junit4]   2> 7469 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10028 (1414361288577908736)]} 0 5
[junit4:junit4]   2> 7471 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10029 (1414361288585248768)]} 0 0
[junit4:junit4]   2> 7474 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7474 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[28 (1414361288584200192)]} 0 4
[junit4:junit4]   2> 7475 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7475 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10029 (1414361288587345920)]} 0 2
[junit4:junit4]   2> 7478 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10030 (1414361288591540224)]} 0 1
[junit4:junit4]   2> 7488 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[29 (1414361288590491648)]} 0 12
[junit4:junit4]   2> 7489 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7490 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10030 (1414361288600977408)]} 0 10
[junit4:junit4]   2> 7493 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10031 (1414361288607268864)]} 0 1
[junit4:junit4]   2> 7496 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 7497 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[29 (1414361288605171712)]} 0 7
[junit4:junit4]   2> 7499 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[30 (1414361288614608896)]} 0 0
[junit4:junit4]   2> 7504 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7504 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7505 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[30 (1414361288616706048)]} 0 4
[junit4:junit4]   2> 7505 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10031 (1414361288610414592)]} 0 10
[junit4:junit4]   2> 7508 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[31 (1414361288622997505)]} 0 1
[junit4:junit4]   2> 7517 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7518 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10032 (1414361288622997504)]} 0 11
[junit4:junit4]   2> 7519 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[31 (1414361288627191808)]} 0 8
[junit4:junit4]   2> 7522 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[32 (1414361288637677568)]} 0 1
[junit4:junit4]   2> 7523 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7523 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10032 (1414361288636628992)]} 0 3
[junit4:junit4]   2> 7526 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10033 (1414361288641871872)]} 0 1
[junit4:junit4]   2> 7526 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7527 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[32 (1414361288640823296)]} 0 3
[junit4:junit4]   2> 7529 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[33 (1414361288646066176)]} 0 0
[junit4:junit4]   2> 7531 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7531 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10033 (1414361288645017600)]} 0 3
[junit4:junit4]   2> 7533 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10033 (-1414361288650260480)]} 0 0
[junit4:junit4]   2> 7534 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7535 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[33 (1414361288649211904)]} 0 3
[junit4:junit4]   2> 7537 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[33 (-1414361288654454784)]} 0 0
[junit4:junit4]   2> 7537 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7538 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10033 (-1414361288653406208)]} 0 3
[junit4:junit4]   2> 7540 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10034 (1414361288657600512)]} 0 0
[junit4:junit4]   2> 7541 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7542 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[33 (-1414361288656551936)]} 0 3
[junit4:junit4]   2> 7544 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[34 (1414361288661794816)]} 0 0
[junit4:junit4]   2> 7547 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7547 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10034 (1414361288660746240)]} 0 4
[junit4:junit4]   2> 7548 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7549 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[34 (1414361288664940544)]} 0 3
[junit4:junit4]   2> 7550 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10035 (1414361288667037696)]} 0 1
[junit4:junit4]   2> 7552 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[35 (1414361288669134848)]} 0 1
[junit4:junit4]   2> 7562 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=7 
[junit4:junit4]   2> 7563 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10035 (1414361288670183424)]} 0 11
[junit4:junit4]   2> 7565 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7565 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10036 (1414361288683814912)]} 0 0
[junit4:junit4]   2> 7566 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[35 (1414361288673329152)]} 0 11
[junit4:junit4]   2> 7568 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[36 (1414361288686960640)]} 0 0
[junit4:junit4]   2> 7571 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7572 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10036 (1414361288686960640)]} 0 4
[junit4:junit4]   2> 7574 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10034 (-1414361288693252096)]} 0 0
[junit4:junit4]   2> 7575 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7575 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[36 (1414361288691154944)]} 0 3
[junit4:junit4]   2> 7578 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[34 (-1414361288697446400)]} 0 1
[junit4:junit4]   2> 7581 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7582 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10034 (-1414361288698494976)]} 0 3
[junit4:junit4]   2> 7583 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7585 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10037 (1414361288703737856)]} 0 1
[junit4:junit4]   2> 7585 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[34 (-1414361288699543552)]} 0 5
[junit4:junit4]   2> 7588 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[37 (1414361288707932160)]} 0 0
[junit4:junit4]   2> 7590 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7592 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10037 (1414361288706883584)]} 0 5
[junit4:junit4]   2> 7594 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7595 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10035 (-1414361288715272192)]} 0 0
[junit4:junit4]   2> 7596 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[37 (1414361288711077888)]} 0 5
[junit4:junit4]   2> 7598 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[35 (-1414361288718417920)]} 0 0
[junit4:junit4]   2> 7600 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7600 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10035 (-1414361288718417920)]} 0 3
[junit4:junit4]   2> 7603 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10038 (1414361288722612224)]} 0 1
[junit4:junit4]   2> 7604 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7605 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[35 (-1414361288722612224)]} 0 3
[junit4:junit4]   2> 7607 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7608 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10038 (1414361288725757952)]} 0 3
[junit4:junit4]   2> 7619 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10037 (-1414361288731000832)]} 0 9
[junit4:junit4]   2> 7624 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7625 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10037 (-1414361288743583744)]} 0 3
[junit4:junit4]   2> 7628 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10039 (1414361288749875200)]} 0 1
[junit4:junit4]   2> 7633 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7633 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10039 (1414361288751972352)]} 0 3
[junit4:junit4]   2> 7636 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10038 (-1414361288758263808)]} 0 0
[junit4:junit4]   2> 7639 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[38 (1414361288727855104)]} 0 32
[junit4:junit4]   2> 7640 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7641 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10038 (-1414361288760360960)]} 0 3
[junit4:junit4]   2> 7643 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7644 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10040 (1414361288765603840)]} 0 1
[junit4:junit4]   2> 7644 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[38 (1414361288763506688)]} 0 3
[junit4:junit4]   2> 7646 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[37 (-1414361288768749568)]} 0 0
[junit4:junit4]   2> 7652 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7653 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7654 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[37 (-1414361288773992448)]} 0 3
[junit4:junit4]   2> 7655 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10040 (1414361288769798144)]} 0 8
[junit4:junit4]   2> 7656 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[39 (1414361288779235328)]} 0 0
[junit4:junit4]   2> 7658 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10041 (1414361288781332480)]} 0 0
[junit4:junit4]   2> 7687 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=20 
[junit4:junit4]   2> 7688 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[39 (1414361288782381056)]} 0 29
[junit4:junit4]   2> 7691 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[38 (-1414361288814886912)]} 0 1
[junit4:junit4]   2> 7695 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7695 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[38 (-1414361288818032640)]} 0 2
[junit4:junit4]   2> 7698 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[40 (1414361288823275520)]} 0 1
[junit4:junit4]   2> 7704 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7704 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[40 (1414361288825372672)]} 0 4
[junit4:junit4]   2> 7791 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7792 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10041 (1414361288783429632)]} 0 132
[junit4:junit4]   2> 7795 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10042 (1414361288923938816)]} 0 1
[junit4:junit4]   2> 7800 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7800 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10042 (1414361288927084544)]} 0 3
[junit4:junit4]   2> 7803 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10039 (-1414361288933376000)]} 0 0
[junit4:junit4]   2> 7807 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7808 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10039 (-1414361288935473152)]} 0 3
[junit4:junit4]   2> 7811 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10043 (1414361288940716032)]} 0 1
[junit4:junit4]   2> 7815 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7816 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10043 (1414361288943861760)]} 0 3
[junit4:junit4]   2> 7820 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[41 (1414361288832712704)]} 0 113
[junit4:junit4]   2> 7821 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10044 (1414361288951201792)]} 0 3
[junit4:junit4]   2> 7826 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7827 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7827 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[41 (1414361288954347520)]} 0 4
[junit4:junit4]   2> 7828 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10044 (1414361288954347521)]} 0 5
[junit4:junit4]   2> 7830 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[42 (1414361288961687552)]} 0 0
[junit4:junit4]   2> 7832 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10045 (1414361288962736128)]} 0 1
[junit4:junit4]   2> 7834 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7835 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[42 (1414361288963784704)]} 0 3
[junit4:junit4]   2> 7837 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7837 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[39 (-1414361288969027584)]} 0 0
[junit4:junit4]   2> 7838 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10045 (1414361288965881856)]} 0 4
[junit4:junit4]   2> 7840 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10044 (-1414361288972173312)]} 0 0
[junit4:junit4]   2> 7843 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7843 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[39 (-1414361288972173312)]} 0 3
[junit4:junit4]   2> 7845 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7845 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10044 (-1414361288975319040)]} 0 3
[junit4:junit4]   2> 7846 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[43 (1414361288977416192)]} 0 1
[junit4:junit4]   2> 7848 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10046 (1414361288980561920)]} 0 0
[junit4:junit4]   2> 7851 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7852 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[43 (1414361288980561920)]} 0 4
[junit4:junit4]   2> 7854 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[44 (1414361288986853376)]} 0 0
[junit4:junit4]   2> 7870 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=17 
[junit4:junit4]   2> 7871 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10046 (1414361288982659072)]} 0 21
[junit4:junit4]   2> 7874 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7876 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10046 (-1414361289009922048)]} 0 0
[junit4:junit4]   2> 7875 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[44 (1414361288988950528)]} 0 19
[junit4:junit4]   2> 7879 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[45 (1414361289013067776)]} 0 0
[junit4:junit4]   2> 7881 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7884 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10046 (-1414361289012019200)]} 0 6
[junit4:junit4]   2> 7890 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7891 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[45 (1414361289019359232)]} 0 5
[junit4:junit4]   2> 7893 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[44 (-1414361289027747840)]} 0 0
[junit4:junit4]   2> 7900 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7901 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10047 (1414361289020407808)]} 0 15
[junit4:junit4]   2> 7901 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[44 (-1414361289031942144)]} 0 6
[junit4:junit4]   2> 7905 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[46 (1414361289039282176)]} 0 1
[junit4:junit4]   2> 7907 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7909 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10047 (1414361289039282176)]} 0 5
[junit4:junit4]   2> 7910 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7911 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10048 (1414361289046622208)]} 0 0
[junit4:junit4]   2> 7912 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[46 (1414361289043476480)]} 0 5
[junit4:junit4]   2> 7915 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[46 (-1414361289050816512)]} 0 0
[junit4:junit4]   2> 7917 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7918 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10048 (1414361289049767936)]} 0 4
[junit4:junit4]   2> 7919 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7920 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[46 (-1414361289052913664)]} 0 3
[junit4:junit4]   2> 7922 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[47 (1414361289058156544)]} 0 0
[junit4:junit4]   2> 7922 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10049 (1414361289056059392)]} 0 1
[junit4:junit4]   2> 7927 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7928 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7928 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10049 (1414361289062350848)]} 0 2
[junit4:junit4]   2> 7929 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[47 (1414361289061302272)]} 0 4
[junit4:junit4]   2> 7932 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[48 (1414361289067593729)]} 0 1
[junit4:junit4]   2> 7933 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10050 (1414361289067593728)]} 0 2
[junit4:junit4]   2> 7936 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7937 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[48 (1414361289070739456)]} 0 3
[junit4:junit4]   2> 7937 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7938 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10050 (1414361289071788032)]} 0 3
[junit4:junit4]   2> 7940 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10048 (-1414361289077030912)]} 0 0
[junit4:junit4]   2> 7941 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[49 (1414361289075982336)]} 0 2
[junit4:junit4]   2> 7944 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7945 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10048 (-1414361289079128064)]} 0 3
[junit4:junit4]   2> 7947 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10051 (1414361289084370944)]} 0 0
[junit4:junit4]   2> 7957 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=12 
[junit4:junit4]   2> 7958 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[49 (1414361289080176640)]} 0 15
[junit4:junit4]   2> 7961 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7961 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10051 (1414361289087516672)]} 0 11
[junit4:junit4]   2> 7963 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[50 (1414361289100099584)]} 0 1
[junit4:junit4]   2> 7964 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10052 (1414361289102196736)]} 0 0
[junit4:junit4]   2> 7970 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7971 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[50 (1414361289105342464)]} 0 4
[junit4:junit4]   2> 7971 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7973 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[48 (-1414361289111633920)]} 0 0
[junit4:junit4]   2> 7976 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10052 (1414361289106391040)]} 0 8
[junit4:junit4]   2> 7979 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10050 (-1414361289117925376)]} 0 0
[junit4:junit4]   2> 7987 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7987 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7989 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10050 (-1414361289120022529)]} 0 8
[junit4:junit4]   2> 7991 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10053 (1414361289130508288)]} 0 0
[junit4:junit4]   2> 7992 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[48 (-1414361289120022528)]} 0 11
[junit4:junit4]   2> 7995 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[51 (1414361289133654016)]} 0 1
[junit4:junit4]   2> 7996 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 7997 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10053 (1414361289133654016)]} 0 4
[junit4:junit4]   2> 8002 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8003 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[51 (1414361289137848320)]} 0 5
[junit4:junit4]   2> 8005 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[52 (1414361289145188352)]} 0 0
[junit4:junit4]   2> 8007 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10054 (1414361289138896896)]} 0 8
[junit4:junit4]   2> 8010 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8011 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8012 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10054 (1414361289149382656)]} 0 3
[junit4:junit4]   2> 8012 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[52 (1414361289147285504)]} 0 5
[junit4:junit4]   2> 8014 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[50 (-1414361289154625537)]} 0 0
[junit4:junit4]   2> 8015 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10055 (1414361289154625536)]} 0 1
[junit4:junit4]   2> 8018 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8019 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8020 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10055 (1414361289157771265)]} 0 3
[junit4:junit4]   2> 8020 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[50 (-1414361289157771264)]} 0 4
[junit4:junit4]   2> 8022 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10054 (-1414361289163014144)]} 0 0
[junit4:junit4]   2> 8023 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[53 (1414361289163014145)]} 0 1
[junit4:junit4]   2> 8027 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8027 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8028 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[53 (1414361289166159873)]} 0 3
[junit4:junit4]   2> 8028 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10054 (-1414361289166159872)]} 0 3
[junit4:junit4]   2> 8031 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10056 (1414361289171402753)]} 0 1
[junit4:junit4]   2> 8031 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[54 (1414361289171402752)]} 0 1
[junit4:junit4]   2> 8046 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8047 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[54 (1414361289174548480)]} 0 14
[junit4:junit4]   2> 8049 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[55 (1414361289191325696)]} 0 0
[junit4:junit4]   2> 8051 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=8 
[junit4:junit4]   2> 8051 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10056 (1414361289174548481)]} 0 18
[junit4:junit4]   2> 8053 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10056 (-1414361289195520000)]} 0 0
[junit4:junit4]   2> 8054 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8055 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[55 (1414361289194471424)]} 0 3
[junit4:junit4]   2> 8056 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[54 (-1414361289198665728)]} 0 0
[junit4:junit4]   2> 8057 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8057 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10056 (-1414361289197617152)]} 0 2
[junit4:junit4]   2> 8060 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8063 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[54 (-1414361289200762880)]} 0 5
[junit4:junit4]   2> 8065 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10057 (1414361289201811456)]} 0 6
[junit4:junit4]   2> 8065 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[56 (1414361289208102912)]} 0 0
[junit4:junit4]   2> 8069 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8070 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8071 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[56 (1414361289210200065)]} 0 4
[junit4:junit4]   2> 8070 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10057 (1414361289210200064)]} 0 3
[junit4:junit4]   2> 8073 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[56 (-1414361289216491520)]} 0 0
[junit4:junit4]   2> 8075 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10058 (1414361289217540096)]} 0 1
[junit4:junit4]   2> 8077 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8079 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[56 (-1414361289218588672)]} 0 4
[junit4:junit4]   2> 8082 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8082 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[57 (1414361289225928704)]} 0 0
[junit4:junit4]   2> 8083 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10058 (1414361289221734400)]} 0 5
[junit4:junit4]   2> 8085 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10059 (1414361289229074432)]} 0 0
[junit4:junit4]   2> 8088 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8088 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[57 (1414361289229074432)]} 0 4
[junit4:junit4]   2> 8090 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8090 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10059 (1414361289231171584)]} 0 3
[junit4:junit4]   2> 8092 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[58 (1414361289235365888)]} 0 1
[junit4:junit4]   2> 8093 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10058 (-1414361289237463040)]} 0 1
[junit4:junit4]   2> 8096 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8096 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8096 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[58 (1414361289238511616)]} 0 2
[junit4:junit4]   2> 8097 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10058 (-1414361289239560192)]} 0 2
[junit4:junit4]   2> 8099 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[59 (1414361289242705920)]} 0 1
[junit4:junit4]   2> 8100 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10060 (1414361289243754496)]} 0 1
[junit4:junit4]   2> 8105 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8106 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10060 (1414361289246900224)]} 0 4
[junit4:junit4]   2> 8111 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10061 (1414361289256337408)]} 0 0
[junit4:junit4]   2> 8125 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8125 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10061 (1414361289260531712)]} 0 10
[junit4:junit4]   2> 8130 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10062 (1414361289276260352)]} 0 0
[junit4:junit4]   2> 8138 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8138 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10062 (1414361289281503232)]} 0 3
[junit4:junit4]   2> 8140 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10060 (-1414361289286746112)]} 0 0
[junit4:junit4]   2> 8144 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8144 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10060 (-1414361289288843264)]} 0 2
[junit4:junit4]   2> 8146 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10063 (1414361289293037568)]} 0 0
[junit4:junit4]   2> 8150 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8150 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10063 (1414361289295134720)]} 0 2
[junit4:junit4]   2> 8152 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10064 (1414361289299329024)]} 0 0
[junit4:junit4]   2> 8153 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=48 
[junit4:junit4]   2> 8154 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[59 (1414361289246900225)]} 0 52
[junit4:junit4]   2> 8156 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[58 (-1414361289303523328)]} 0 0
[junit4:junit4]   2> 8156 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8157 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10064 (1414361289301426176)]} 0 3
[junit4:junit4]   2> 8160 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8160 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[58 (-1414361289305620480)]} 0 2
[junit4:junit4]   2> 8163 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[60 (1414361289309814784)]} 0 1
[junit4:junit4]   2> 8167 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8168 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[60 (1414361289312960512)]} 0 3
[junit4:junit4]   2> 8168 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10065 (1414361289306669056)]} 0 9
[junit4:junit4]   2> 8170 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[61 (1414361289318203392)]} 0 1
[junit4:junit4]   2> 8172 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8173 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10065 (1414361289318203392)]} 0 3
[junit4:junit4]   2> 8174 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8174 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[61 (1414361289320300544)]} 0 2
[junit4:junit4]   2> 8175 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10061 (-1414361289323446272)]} 0 0
[junit4:junit4]   2> 8177 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[62 (1414361289324494848)]} 0 1
[junit4:junit4]   2> 8178 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8178 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10061 (-1414361289325543424)]} 0 2
[junit4:junit4]   2> 8181 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8181 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10066 (1414361289329737728)]} 0 1
[junit4:junit4]   2> 8182 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[62 (1414361289327640576)]} 0 3
[junit4:junit4]   2> 8185 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[60 (-1414361289333932032)]} 0 0
[junit4:junit4]   2> 8185 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8186 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10066 (1414361289331834880)]} 0 3
[junit4:junit4]   2> 8188 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10067 (1414361289336029184)]} 0 1
[junit4:junit4]   2> 8188 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8189 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[60 (-1414361289336029184)]} 0 2
[junit4:junit4]   2> 8191 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[63 (1414361289339174912)]} 0 1
[junit4:junit4]   2> 8198 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=7 
[junit4:junit4]   2> 8199 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10067 (1414361289338126336)]} 0 10
[junit4:junit4]   2> 8200 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8201 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10063 (-1414361289350709248)]} 0 0
[junit4:junit4]   2> 8201 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[63 (1414361289341272064)]} 0 9
[junit4:junit4]   2> 8203 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[64 (1414361289352806400)]} 0 0
[junit4:junit4]   2> 8204 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8205 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10063 (-1414361289351757824)]} 0 3
[junit4:junit4]   2> 8207 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10068 (1414361289357000704)]} 0 1
[junit4:junit4]   2> 8207 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8208 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[64 (1414361289354903552)]} 0 3
[junit4:junit4]   2> 8210 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[65 (1414361289360146432)]} 0 0
[junit4:junit4]   2> 8211 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8211 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10068 (1414361289359097856)]} 0 2
[junit4:junit4]   2> 8214 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10069 (1414361289363292160)]} 0 1
[junit4:junit4]   2> 8214 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8214 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[65 (1414361289362243584)]} 0 2
[junit4:junit4]   2> 8216 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[61 (-1414361289366437888)]} 0 0
[junit4:junit4]   2> 8218 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8219 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10069 (1414361289366437888)]} 0 3
[junit4:junit4]   2> 8221 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8221 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10066 (-1414361289371680768)]} 0 0
[junit4:junit4]   2> 8222 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[61 (-1414361289369583616)]} 0 3
[junit4:junit4]   2> 8224 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[66 (1414361289374826496)]} 0 1
[junit4:junit4]   2> 8225 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8227 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10066 (-1414361289374826496)]} 0 4
[junit4:junit4]   2> 8251 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8252 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[66 (1414361289379020800)]} 0 24
[junit4:junit4]   2> 8254 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[67 (1414361289406283776)]} 0 0
[junit4:junit4]   2> 8260 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10070 (1414361289380069376)]} 0 31
[junit4:junit4]   2> 8262 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8263 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[67 (1414361289409429504)]} 0 7
[junit4:junit4]   2> 8265 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8266 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[63 (-1414361289418866688)]} 0 0
[junit4:junit4]   2> 8267 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10070 (1414361289414672384)]} 0 5
[junit4:junit4]   2> 8271 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8271 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10068 (-1414361289424109568)]} 0 0
[junit4:junit4]   2> 8272 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[63 (-1414361289422012416)]} 0 4
[junit4:junit4]   2> 8275 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[68 (1414361289427255296)]} 0 1
[junit4:junit4]   2> 8276 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8277 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10068 (-1414361289427255296)]} 0 3
[junit4:junit4]   2> 8279 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8280 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10071 (1414361289432498176)]} 0 1
[junit4:junit4]   2> 8280 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[68 (1414361289430401024)]} 0 3
[junit4:junit4]   2> 8283 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[69 (1414361289435643904)]} 0 1
[junit4:junit4]   2> 8298 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=14 
[junit4:junit4]   2> 8299 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10071 (1414361289435643904)]} 0 17
[junit4:junit4]   2> 8302 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10070 (-1414361289456615424)]} 0 1
[junit4:junit4]   2> 8305 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8306 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8307 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10070 (-1414361289458712576)]} 0 3
[junit4:junit4]   2> 8309 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[69 (1414361289439838208)]} 0 23
[junit4:junit4]   2> 8310 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10072 (1414361289463955456)]} 0 1
[junit4:junit4]   2> 8311 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[66 (-1414361289466052608)]} 0 0
[junit4:junit4]   2> 8315 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8316 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8316 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[66 (-1414361289468149760)]} 0 3
[junit4:junit4]   2> 8317 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10072 (1414361289467101184)]} 0 5
[junit4:junit4]   2> 8318 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[70 (1414361289473392640)]} 0 0
[junit4:junit4]   2> 8319 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10071 (-1414361289474441216)]} 0 0
[junit4:junit4]   2> 8323 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8323 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10071 (-1414361289476538368)]} 0 2
[junit4:junit4]   2> 8325 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8325 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[70 (1414361289476538369)]} 0 4
[junit4:junit4]   2> 8326 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10073 (1414361289481781248)]} 0 1
[junit4:junit4]   2> 8327 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[68 (-1414361289482829824)]} 0 0
[junit4:junit4]   2> 8330 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8331 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10073 (1414361289483878400)]} 0 3
[junit4:junit4]   2> 8333 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8333 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10072 (-1414361289489121280)]} 0 0
[junit4:junit4]   2> 8334 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[68 (-1414361289485975552)]} 0 4
[junit4:junit4]   2> 8337 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[71 (1414361289493315584)]} 0 0
[junit4:junit4]   2> 8340 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8340 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10072 (-1414361289493315584)]} 0 3
[junit4:junit4]   2> 8347 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8348 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[71 (1414361289497509888)]} 0 7
[junit4:junit4]   2> 8350 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[70 (-1414361289506947072)]} 0 0
[junit4:junit4]   2> 8351 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10074 (1414361289499607040)]} 0 8
[junit4:junit4]   2> 8354 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8354 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[70 (-1414361289509044224)]} 0 2
[junit4:junit4]   2> 8355 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8357 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[72 (1414361289513238528)]} 0 1
[junit4:junit4]   2> 8358 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10074 (1414361289510092800)]} 0 5
[junit4:junit4]   2> 8361 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10075 (1414361289518481408)]} 0 1
[junit4:junit4]   2> 8369 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 8369 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 8370 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[72 (1414361289520578560)]} 0 10
[junit4:junit4]   2> 8370 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10075 (1414361289521627136)]} 0 6
[junit4:junit4]   2> 8372 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[71 (-1414361289530015744)]} 0 0
[junit4:junit4]   2> 8372 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10076 (1414361289530015745)]} 0 0
[junit4:junit4]   2> 8375 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8376 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8376 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[71 (-1414361289532112896)]} 0 2
[junit4:junit4]   2> 8376 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10076 (1414361289532112897)]} 0 2
[junit4:junit4]   2> 8379 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[73 (1414361289536307200)]} 0 1
[junit4:junit4]   2> 8379 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10077 (1414361289537355776)]} 0 1
[junit4:junit4]   2> 8394 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=11 
[junit4:junit4]   2> 8395 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[73 (1414361289539452928)]} 0 14
[junit4:junit4]   2> 8398 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[72 (-1414361289557278720)]} 0 1
[junit4:junit4]   2> 8402 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8403 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[72 (-1414361289560424448)]} 0 2
[junit4:junit4]   2> 8405 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[74 (1414361289563570176)]} 0 1
[junit4:junit4]   2> 8410 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8410 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[74 (1414361289566715904)]} 0 4
[junit4:junit4]   2> 8413 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[75 (1414361289573007360)]} 0 1
[junit4:junit4]   2> 8416 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8417 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10077 (1414361289539452929)]} 0 36
[junit4:junit4]   2> 8417 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8418 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[75 (1414361289575104512)]} 0 3
[junit4:junit4]   2> 8419 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10075 (-1414361289579298816)]} 0 0
[junit4:junit4]   2> 8421 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[76 (1414361289580347392)]} 0 1
[junit4:junit4]   2> 8424 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8425 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10075 (-1414361289582444544)]} 0 3
[junit4:junit4]   2> 8426 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8426 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[76 (1414361289584541696)]} 0 2
[junit4:junit4]   2> 8427 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10078 (1414361289586638848)]} 0 1
[junit4:junit4]   2> 8428 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[77 (1414361289588736000)]} 0 0
[junit4:junit4]   2> 8432 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8433 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[77 (1414361289590833152)]} 0 3
[junit4:junit4]   2> 8435 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[75 (-1414361289596076032)]} 0 0
[junit4:junit4]   2> 8438 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8438 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10078 (1414361289596076032)]} 0 3
[junit4:junit4]   2> 8439 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8440 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[75 (-1414361289599221760)]} 0 3
[junit4:junit4]   2> 8440 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10076 (-1414361289601318912)]} 0 0
[junit4:junit4]   2> 8443 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[78 (1414361289604464640)]} 0 0
[junit4:junit4]   2> 8444 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8445 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10076 (-1414361289603416064)]} 0 3
[junit4:junit4]   2> 8447 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10079 (1414361289608658944)]} 0 0
[junit4:junit4]   2> 8449 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8449 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[78 (1414361289607610368)]} 0 3
[junit4:junit4]   2> 8451 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[76 (-1414361289612853248)]} 0 0
[junit4:junit4]   2> 8452 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8453 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10079 (1414361289611804672)]} 0 3
[junit4:junit4]   2> 8455 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10077 (-1414361289617047552)]} 0 0
[junit4:junit4]   2> 8458 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8459 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8460 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10077 (-1414361289620193280)]} 0 2
[junit4:junit4]   2> 8460 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[76 (-1414361289619144704)]} 0 3
[junit4:junit4]   2> 8464 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[79 (1414361289626484736)]} 0 0
[junit4:junit4]   2> 8469 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8470 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[79 (1414361289629630464)]} 0 3
[junit4:junit4]   2> 8472 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[77 (-1414361289634873344)]} 0 0
[junit4:junit4]   2> 8477 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8487 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[77 (-1414361289636970496)]} 0 13
[junit4:junit4]   2> 8499 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10080 (1414361289624387584)]} 0 37
[junit4:junit4]   2> 8500 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[80 (1414361289652699136)]} 0 11
[junit4:junit4]   2> 8515 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=8 
[junit4:junit4]   2> 8516 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8516 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[80 (1414361289666330624)]} 0 14
[junit4:junit4]   2> 8516 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10080 (1414361289667379200)]} 0 13
[junit4:junit4]   2> 8519 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10081 (1414361289683107841)]} 0 1
[junit4:junit4]   2> 8519 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[81 (1414361289683107840)]} 0 1
[junit4:junit4]   2> 8524 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8524 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8524 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[81 (1414361289686253568)]} 0 3
[junit4:junit4]   2> 8524 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10081 (1414361289686253569)]} 0 3
[junit4:junit4]   2> 8526 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10078 (-1414361289691496449)]} 0 0
[junit4:junit4]   2> 8526 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[78 (-1414361289691496448)]} 0 0
[junit4:junit4]   2> 8530 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8531 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10078 (-1414361289694642176)]} 0 2
[junit4:junit4]   2> 8534 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10082 (1414361289698836480)]} 0 1
[junit4:junit4]   2> 8535 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 8536 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[78 (-1414361289694642177)]} 0 7
[junit4:junit4]   2> 8538 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8539 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[82 (1414361289705127936)]} 0 0
[junit4:junit4]   2> 8539 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10082 (1414361289701982208)]} 0 3
[junit4:junit4]   2> 8541 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10080 (-1414361289707225088)]} 0 0
[junit4:junit4]   2> 8544 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8544 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[82 (1414361289707225088)]} 0 3
[junit4:junit4]   2> 8545 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8546 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10080 (-1414361289709322240)]} 0 3
[junit4:junit4]   2> 8547 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[80 (-1414361289712467968)]} 0 0
[junit4:junit4]   2> 8548 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10083 (1414361289714565120)]} 0 1
[junit4:junit4]   2> 8551 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8551 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[80 (-1414361289714565120)]} 0 3
[junit4:junit4]   2> 8552 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8553 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10083 (1414361289716662272)]} 0 3
[junit4:junit4]   2> 8554 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[83 (1414361289720856576)]} 0 0
[junit4:junit4]   2> 8555 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10084 (1414361289721905152)]} 0 0
[junit4:junit4]   2> 8558 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8559 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[83 (1414361289722953728)]} 0 3
[junit4:junit4]   2> 8561 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8561 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10084 (1414361289725050880)]} 0 3
[junit4:junit4]   2> 8562 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[84 (1414361289729245184)]} 0 0
[junit4:junit4]   2> 8563 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10084 (-1414361289730293760)]} 0 0
[junit4:junit4]   2> 8567 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8567 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[84 (1414361289731342336)]} 0 3
[junit4:junit4]   2> 8568 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8569 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10084 (-1414361289733439488)]} 0 3
[junit4:junit4]   2> 8570 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[84 (-1414361289737633792)]} 0 1
[junit4:junit4]   2> 8571 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10085 (1414361289738682368)]} 0 0
[junit4:junit4]   2> 8573 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8574 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[84 (-1414361289739730944)]} 0 2
[junit4:junit4]   2> 8576 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[85 (1414361289743925248)]} 0 0
[junit4:junit4]   2> 8582 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=7 
[junit4:junit4]   2> 8583 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10085 (1414361289740779520)]} 0 10
[junit4:junit4]   2> 8585 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10085 (-1414361289753362432)]} 0 0
[junit4:junit4]   2> 8589 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8590 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8591 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10085 (-1414361289756508160)]} 0 3
[junit4:junit4]   2> 8591 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[85 (1414361289747070976)]} 0 12
[junit4:junit4]   2> 8593 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[85 (-1414361289761751041)]} 0 0
[junit4:junit4]   2> 8593 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10086 (1414361289761751040)]} 0 0
[junit4:junit4]   2> 8597 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8598 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8599 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[85 (-1414361289763848192)]} 0 4
[junit4:junit4]   2> 8599 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10086 (1414361289763848193)]} 0 4
[junit4:junit4]   2> 8601 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10086 (-1414361289770139648)]} 0 0
[junit4:junit4]   2> 8601 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[86 (1414361289770139649)]} 0 0
[junit4:junit4]   2> 8605 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8605 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8606 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[86 (1414361289772236801)]} 0 3
[junit4:junit4]   2> 8606 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10086 (-1414361289772236800)]} 0 3
[junit4:junit4]   2> 8608 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[86 (-1414361289777479680)]} 0 0
[junit4:junit4]   2> 8608 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10087 (1414361289777479681)]} 0 0
[junit4:junit4]   2> 8612 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8612 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[86 (-1414361289779576832)]} 0 2
[junit4:junit4]   2> 8612 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8613 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10087 (1414361289779576833)]} 0 3
[junit4:junit4]   2> 8614 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[87 (1414361289783771136)]} 0 0
[junit4:junit4]   2> 8615 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10087 (-1414361289784819712)]} 0 0
[junit4:junit4]   2> 8618 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8619 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[87 (1414361289785868288)]} 0 3
[junit4:junit4]   2> 8619 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8619 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10087 (-1414361289786916864)]} 0 3
[junit4:junit4]   2> 8621 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[87 (-1414361289791111168)]} 0 0
[junit4:junit4]   2> 8624 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10088 (1414361289794256896)]} 0 1
[junit4:junit4]   2> 8625 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8628 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[87 (-1414361289793208320)]} 0 5
[junit4:junit4]   2> 8630 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[88 (1414361289800548352)]} 0 0
[junit4:junit4]   2> 8631 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8632 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10088 (1414361289798451200)]} 0 5
[junit4:junit4]   2> 8635 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10089 (1414361289804742656)]} 0 1
[junit4:junit4]   2> 8636 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8636 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[88 (1414361289802645504)]} 0 4
[junit4:junit4]   2> 8638 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[89 (1414361289808936960)]} 0 0
[junit4:junit4]   2> 8639 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8639 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10089 (1414361289807888384)]} 0 2
[junit4:junit4]   2> 8641 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10088 (-1414361289812082688)]} 0 0
[junit4:junit4]   2> 8643 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8643 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[89 (1414361289812082688)]} 0 2
[junit4:junit4]   2> 8645 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8645 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[88 (-1414361289816276992)]} 0 0
[junit4:junit4]   2> 8645 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10088 (-1414361289814179840)]} 0 2
[junit4:junit4]   2> 8649 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8649 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[88 (-1414361289818374144)]} 0 2
[junit4:junit4]   2> 8652 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10090 (1414361289818374144)]} 0 5
[junit4:junit4]   2> 8659 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[90 (1414361289823617024)]} 0 8
[junit4:junit4]   2> 8661 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=5 
[junit4:junit4]   2> 8661 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10090 (1414361289826762752)]} 0 7
[junit4:junit4]   2> 8663 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10089 (-1414361289835151360)]} 0 0
[junit4:junit4]   2> 8667 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8668 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10089 (-1414361289838297088)]} 0 3
[junit4:junit4]   2> 8669 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8670 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[90 (1414361289833054208)]} 0 9
[junit4:junit4]   2> 8671 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10091 (1414361289842491392)]} 0 2
[junit4:junit4]   2> 8671 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[89 (-1414361289843539968)]} 0 0
[junit4:junit4]   2> 8675 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8675 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8675 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[89 (-1414361289845637120)]} 0 2
[junit4:junit4]   2> 8676 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10091 (1414361289844588544)]} 0 4
[junit4:junit4]   2> 8677 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10091 (-1414361289849831424)]} 0 0
[junit4:junit4]   2> 8678 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[91 (1414361289849831425)]} 0 1
[junit4:junit4]   2> 8681 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8682 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8682 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10091 (-1414361289851928576)]} 0 3
[junit4:junit4]   2> 8682 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[91 (1414361289852977152)]} 0 2
[junit4:junit4]   2> 8684 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[91 (-1414361289857171456)]} 0 0
[junit4:junit4]   2> 8685 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10092 (1414361289857171457)]} 0 1
[junit4:junit4]   2> 8688 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8689 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8689 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[91 (-1414361289860317184)]} 0 3
[junit4:junit4]   2> 8689 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10092 (1414361289860317185)]} 0 3
[junit4:junit4]   2> 8691 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[92 (1414361289864511488)]} 0 0
[junit4:junit4]   2> 8691 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10093 (1414361289864511489)]} 0 0
[junit4:junit4]   2> 8695 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8695 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8695 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10093 (1414361289866608641)]} 0 2
[junit4:junit4]   2> 8695 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[92 (1414361289866608640)]} 0 2
[junit4:junit4]   2> 8697 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10094 (1414361289870802944)]} 0 0
[junit4:junit4]   2> 8698 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[93 (1414361289870802945)]} 0 1
[junit4:junit4]   2> 8702 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8703 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10094 (1414361289873948672)]} 0 3
[junit4:junit4]   2> 8705 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10093 (-1414361289879191552)]} 0 0
[junit4:junit4]   2> 8707 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 8708 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[93 (1414361289876045824)]} 0 6
[junit4:junit4]   2> 8710 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[94 (1414361289884434432)]} 0 0
[junit4:junit4]   2> 8711 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8713 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10093 (-1414361289882337280)]} 0 5
[junit4:junit4]   2> 8716 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10095 (1414361289889677312)]} 0 1
[junit4:junit4]   2> 8715 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8717 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[94 (1414361289887580160)]} 0 4
[junit4:junit4]   2> 8719 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[93 (-1414361289893871616)]} 0 0
[junit4:junit4]   2> 8724 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8727 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[93 (-1414361289897017344)]} 0 6
[junit4:junit4]   2> 8730 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[95 (1414361289905405952)]} 0 0
[junit4:junit4]   2> 8742 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8743 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[95 (1414361289907503104)]} 0 11
[junit4:junit4]   2> 8745 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[96 (1414361289921134592)]} 0 0
[junit4:junit4]   2> 8751 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8751 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[96 (1414361289924280320)]} 0 4
[junit4:junit4]   2> 8753 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[96 (-1414361289929523200)]} 0 0
[junit4:junit4]   2> 8757 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8758 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[96 (-1414361289932668928)]} 0 2
[junit4:junit4]   2> 8761 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[97 (1414361289936863232)]} 0 1
[junit4:junit4]   2> 8770 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8771 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[97 (1414361289944203264)]} 0 4
[junit4:junit4]   2> 8773 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=51 
[junit4:junit4]   2> 8780 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[98 (1414361289950494720)]} 0 7
[junit4:junit4]   2> 8781 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10095 (1414361289892823040)]} 0 63
[junit4:junit4]   2> 8784 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10096 (1414361289960980480)]} 0 1
[junit4:junit4]   2> 8786 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8786 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[98 (1414361289960980480)]} 0 3
[junit4:junit4]   2> 8789 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[99 (1414361289966223360)]} 0 1
[junit4:junit4]   2> 8790 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8791 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10096 (1414361289965174784)]} 0 4
[junit4:junit4]   2> 8793 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[10096 (-1414361289971466240)]} 0 0
[junit4:junit4]   2> 8796 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8797 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8798 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[99 (1414361289971466240)]} 0 5
[junit4:junit4]   2> 8799 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[10096 (-1414361289974611968)]} 0 4
[junit4:junit4]   2> 8801 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[98 (-1414361289978806272)]} 0 1
[junit4:junit4]   2> 8803 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10097 (1414361289980903424)]} 0 1
[junit4:junit4]   2> 8804 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8806 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[98 (-1414361289981952000)]} 0 3
[junit4:junit4]   2> 8808 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8808 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10097 (1414361289984049152)]} 0 3
[junit4:junit4]   2> 8810 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[100 (1414361289988243456)]} 0 1
[junit4:junit4]   2> 8811 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10098 (1414361289989292032)]} 0 1
[junit4:junit4]   2> 8817 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8818 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 8818 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10098 (1414361289992437760)]} 0 5
[junit4:junit4]   2> 8819 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[100 (1414361289993486336)]} 0 5
[junit4:junit4]   2> 8821 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[101 (1414361290000826369)]} 0 0
[junit4:junit4]   2> 8822 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[10099 (1414361290000826368)]} 0 2
[junit4:junit4]   2> 8837 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=9 
[junit4:junit4]   2> 8843 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[101 (1414361290002923520)]} 0 20
[junit4:junit4]   2> 8846 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8847 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[99 (-1414361290028089344)]} 0 0
[junit4:junit4]   2> 8847 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[10099 (1414361290003972096)]} 0 23
[junit4:junit4]   2> 8849 T1328 C58 P51795 /update {wt=javabin&version=2} {delete=[10098 (-1414361290030186496)]} 0 0
[junit4:junit4]   2> 8851 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 8851 T1343 C57 P41901 /update {wt=javabin&version=2} {delete=[99 (-1414361290030186496)]} 0 2
[junit4:junit4]   2> 8853 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8854 T1344 C57 P41901 /update {wt=javabin&version=2} {delete=[10098 (-1414361290033332224)]} 0 3
[junit4:junit4]   2> 8855 T1328 C58 P51795 /update {wt=javabin&version=2} {add=[102 (1414361290035429376)]} 0 1
[junit4:junit4]   2> 8856 T1327 C58 P51795 /update {wt=javabin&version=2} {add=[10100 (1414361290037526528)]} 0 0
[junit4:junit4]   2> 8860 T1354 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8861 T1344 C57 P41901 /update {wt=javabin&version=2} {add=[102 (1414361290038575104)]} 0 4
[junit4:junit4]   2> 8862 T1353 C56 P57321 REQ /update {distrib.from=http://127.0.0.1:41901/solr/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 8862 T1343 C57 P41901 /update {wt=javabin&version=2} {add=[10100 (1414361290040672256)]} 0 3
[junit4:junit4]   2> 8863 T1327 C58 P51795 /update {wt=javabin&version=2} {delete=[100 (-14143

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

d! 57321
[junit4:junit4]   2> 27201 T1315 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=23293552
[junit4:junit4]   2> 28899 T1480 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost.localdomain/127.0.0.1:35967
[junit4:junit4]   2> 29000 T1481 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 29000 T1315 oaz.ZooKeeper.close Session: 0x13a0d2175bd0007 closed
[junit4:junit4]   2> 29001 T1315 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 29121 T1315 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=RecoveryZkTest -Dtests.method=testDistribSearch -Dtests.seed=725B254C078B406F -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=es_PY -Dtests.timezone=Pacific/Norfolk -Dtests.file.encoding=UTF-8
[junit4:junit4] ERROR   29.2s J0 | RecoveryZkTest.testDistribSearch <<<
[junit4:junit4]    > Throwable #1: org.apache.solr.common.SolrException: Server at http://127.0.0.1:57321/solr/collection1 returned non ok status:404, message:Can not find: /solr/collection1/select
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([725B254C078B406F:F3BDAB5470D42053]:0)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:374)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:181)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:90)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:301)
[junit4:junit4]    > 	at org.apache.solr.cloud.RecoveryZkTest.doTest(RecoveryZkTest.java:92)
[junit4:junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:695)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
[junit4:junit4]    > 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4:junit4]    > 	at java.lang.reflect.Method.invoke(Method.java:474)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 29157 T1315 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4]   2> NOTE: test params are: codec=Lucene40: {range_facet_l=PostingsFormat(name=SimpleText), _version_=PostingsFormat(name=SimpleText), range_facet_sl=Lucene40(minBlockSize=42 maxBlockSize=165), rnd_b=PostingsFormat(name=MockSep), other_tl1=PostingsFormat(name=SimpleText), intDefault=PostingsFormat(name=SimpleText), a_si=Pulsing40(freqCutoff=14 minBlockSize=42 maxBlockSize=165), id=PostingsFormat(name=MockSep), a_t=PostingsFormat(name=SimpleText), multiDefault=Pulsing40(freqCutoff=14 minBlockSize=42 maxBlockSize=165), text=Lucene40(minBlockSize=42 maxBlockSize=165), timestamp=PostingsFormat(name=SimpleText), range_facet_si=Pulsing40(freqCutoff=14 minBlockSize=42 maxBlockSize=165)}, sim=DefaultSimilarity, locale=es_PY, timezone=Pacific/Norfolk
[junit4:junit4]   2> NOTE: Linux 3.2.0-31-generic i386/Oracle Corporation 1.8.0-ea (32-bit)/cpus=8,threads=1,free=187917568,total=303104000
[junit4:junit4]   2> NOTE: All tests run in this JVM: [TestConfig, TestCollationField, SpatialFilterTest, CurrencyFieldTest, NoCacheHeaderTest, TestLuceneMatchVersion, TestPerFieldSimilarity, CopyFieldTest, SolrCoreCheckLockOnStartupTest, LoggingHandlerTest, SuggesterFSTTest, ClusterStateTest, TestGroupingSearch, TestExtendedDismaxParser, DefaultValueUpdateProcessorTest, SpellPossibilityIteratorTest, TestFaceting, CircularListTest, TestBinaryResponseWriter, SuggesterWFSTTest, TestFastLRUCache, AlternateDirectoryTest, SolrCmdDistributorTest, SystemInfoHandlerTest, IndexBasedSpellCheckerTest, DistributedTermsComponentTest, ResponseLogComponentTest, CoreAdminHandlerTest, DirectSolrConnectionTest, TestStressRecovery, TestRTGBase, TestPseudoReturnFields, ZkCLITest, PreAnalyzedFieldTest, NumericFieldsTest, LeaderElectionIntegrationTest, DistanceFunctionTest, AnalysisAfterCoreReloadTest, TestJoin, TestCharFilters, TestFastOutputStream, MoreLikeThisHandlerTest, TestWordDelimiterFilterFactory, SampleTest, TestLMJelinekMercerSimilarityFactory, TestFiltering, TestIndexingPerformance, TestXIncludeConfig, TestJmxMonitoredMap, TestNumberUtils, CSVRequestHandlerTest, MinimalSchemaTest, TestLMDirichletSimilarityFactory, FastVectorHighlighterTest, PluginInfoTest, TestCoreContainer, OverseerTest, RecoveryZkTest]
[junit4:junit4] Completed on J0 in 29.19s, 1 test, 1 error <<< FAILURES!

[...truncated 352 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:40: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:180: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/module-build.xml:61: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1143: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:816: There were test failures: 230 suites, 954 tests, 1 error, 7 ignored (2 assumptions)

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



Mime
View raw message