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/ibm-j9-jdk7) - Build # 950 - Failure!
Date Fri, 07 Sep 2012 22:25:43 GMT
Build: http://jenkins.sd-datasolutions.de/job/Lucene-Solr-trunk-Linux/950/
Java: 32bit/ibm-j9-jdk7 -Xjit:exclude={org/apache/lucene/util/fst/FST.pack(IIF)Lorg/apache/lucene/util/fst/FST;}

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

Error Message:
Server at http://localhost:44424/solr/collection1 returned non ok status:404, message:Can not find: /solr/collection1/select

Stack Trace:
org.apache.solr.common.SolrException: Server at http://localhost:44424/solr/collection1 returned non ok status:404, message:Can not find: /solr/collection1/select
	at __randomizedtesting.SeedInfo.seed([BC48C95B6D95671F:3DAE47431ACA0723]:0)
	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:373)
	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:182)
	at org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:90)
	at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:324)
	at org.apache.solr.cloud.RecoveryZkTest.doTest(RecoveryZkTest.java:92)
	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:691)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:88)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
	at java.lang.reflect.Method.invoke(Method.java:613)
	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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:40)
	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:777)




Build Log:
[...truncated 7860 lines...]
[junit4:junit4] Suite: org.apache.solr.cloud.RecoveryZkTest
[junit4:junit4]   2> 3 T1289 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4:junit4]   2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./solrtest-RecoveryZkTest-1347056441586
[junit4:junit4]   2> 4 T1289 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4]   2> 5 T1290 oazs.ZooKeeperServer.setTickTime tickTime set to 3000
[junit4:junit4]   2> 6 T1290 oazs.NIOServerCnxn$Factory.<init> binding to port 0.0.0.0/0.0.0.0:0
[junit4:junit4]   2> 7 T1290 oazsp.FileTxnSnapLog.save Snapshotting: 0
[junit4:junit4]   2> 104 T1289 oasc.ZkTestServer.run start zk server on port:40845
[junit4:junit4]   2> 105 T1289 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:40845 sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@884f6e1b
[junit4:junit4]   2> 107 T1295 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:40845
[junit4:junit4]   2> 107 T1289 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 108 T1295 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:40845, initiating session
[junit4:junit4]   2> 108 T1291 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:40965
[junit4:junit4]   2> 108 T1291 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:40965
[junit4:junit4]   2> 110 T1293 oazsp.FileTxnLog.append Creating new log file: log.1
[junit4:junit4]   2> 112 T1293 oazs.NIOServerCnxn.finishSessionInit Established session 0x139a2d218f70000 with negotiated timeout 10000 for client /127.0.0.1:40965
[junit4:junit4]   2> 112 T1295 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:40845, sessionid = 0x139a2d218f70000, negotiated timeout = 10000
[junit4:junit4]   2> 113 T1296 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@884f6e1b name:ZooKeeperConnection Watcher:127.0.0.1:40845 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 113 T1289 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 114 T1289 oascc.SolrZkClient.makePath makePath: /solr
[junit4:junit4]   2> 116 T1294 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x139a2d218f70000
[junit4:junit4]   2> 117 T1291 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:40965 which had sessionid 0x139a2d218f70000
[junit4:junit4]   2> 117 T1289 oaz.ZooKeeper.close Session: 0x139a2d218f70000 closed
[junit4:junit4]   2> 118 T1296 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 118 T1289 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:40845/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@c80fcd3f
[junit4:junit4]   2> 120 T1297 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:40845
[junit4:junit4]   2> 120 T1289 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 120 T1297 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:40845, initiating session
[junit4:junit4]   2> 121 T1291 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:40966
[junit4:junit4]   2> 121 T1291 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:40966
[junit4:junit4]   2> 123 T1293 oazs.NIOServerCnxn.finishSessionInit Established session 0x139a2d218f70001 with negotiated timeout 10000 for client /127.0.0.1:40966
[junit4:junit4]   2> 123 T1297 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:40845, sessionid = 0x139a2d218f70001, negotiated timeout = 10000
[junit4:junit4]   2> 124 T1298 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@c80fcd3f name:ZooKeeperConnection Watcher:127.0.0.1:40845/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 125 T1289 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 125 T1289 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4:junit4]   2> 127 T1289 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4:junit4]   2> 129 T1289 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4:junit4]   2> 131 T1289 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4:junit4]   2> 133 T1289 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> 134 T1289 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 138 T1289 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> 139 T1289 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4:junit4]   2> 142 T1289 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> 143 T1289 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 146 T1289 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> 146 T1289 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
[junit4:junit4]   2> 148 T1289 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> 149 T1289 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
[junit4:junit4]   2> 150 T1289 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> 151 T1289 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
[junit4:junit4]   2> 152 T1289 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> 153 T1289 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 155 T1289 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> 155 T1289 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 157 T1289 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> 157 T1289 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 159 T1289 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> 159 T1289 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
[junit4:junit4]   2> 161 T1294 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x139a2d218f70001
[junit4:junit4]   2> 161 T1298 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 161 T1289 oaz.ZooKeeper.close Session: 0x139a2d218f70001 closed
[junit4:junit4]   2> 161 T1291 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:40966 which had sessionid 0x139a2d218f70001
[junit4:junit4]   2> 162 T1289 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 164 T1289 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:45579
[junit4:junit4]   2> 165 T1289 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 166 T1289 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 166 T1289 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 175 T1289 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 176 T1289 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 176 T1289 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 177 T1289 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 177 T1289 oasc.CoreContainer.<init> New CoreContainer 1275641160
[junit4:junit4]   2> 178 T1289 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 179 T1289 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 198 T1289 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 210 T1289 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:40845/solr
[junit4:junit4]   2> 211 T1289 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:40845/solr sessionTimeout=8000 watcher=org.apache.solr.common.cloud.ConnectionManager@e791a026
[junit4:junit4]   2> 213 T1308 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:40845
[junit4:junit4]   2> 213 T1289 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 216 T1291 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:40968
[junit4:junit4]   2> 216 T1308 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:40845, initiating session
[junit4:junit4]   2> 217 T1291 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:40968
[junit4:junit4]   2> 218 T1293 oazs.NIOServerCnxn.finishSessionInit Established session 0x139a2d218f70002 with negotiated timeout 8000 for client /127.0.0.1:40968
[junit4:junit4]   2> 218 T1308 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:40845, sessionid = 0x139a2d218f70002, negotiated timeout = 8000
[junit4:junit4]   2> 221 T1309 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@e791a026 name:ZooKeeperConnection Watcher:127.0.0.1:40845/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 221 T1289 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 223 T1294 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139a2d218f70002 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 224 T1289 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4:junit4]   2> 226 T1289 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:45579_solr
[junit4:junit4]   2> 227 T1294 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139a2d218f70002 type:delete cxid:0x7 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:45579_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:45579_solr
[junit4:junit4]   2> 228 T1289 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:45579_solr
[junit4:junit4]   2> 230 T1289 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 231 T1289 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 232 T1289 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 232 T1289 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 233 T1289 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 234 T1289 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 235 T1289 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 236 T1289 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 237 T1289 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 238 T1289 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 246 T1289 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4:junit4]   2> 257 T1294 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139a2d218f70002 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> 257 T1289 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4]   2> 260 T1289 oasc.Overseer.start Overseer (id=88280690956107778-127.0.0.1:45579_solr-n_0000000000) starting
[junit4:junit4]   2> 262 T1294 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139a2d218f70002 type:create cxid:0x1a zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 263 T1294 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139a2d218f70002 type:create cxid:0x1b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 264 T1294 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139a2d218f70002 type:create cxid:0x1c zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 265 T1294 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139a2d218f70002 type:create cxid:0x1d zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 266 T1311 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
[junit4:junit4]   2> 268 T1289 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4:junit4]   2> 273 T1289 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 280 T1289 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 280 T1310 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4]   2> 281 T1289 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection
[junit4:junit4]   2> 282 T1289 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 283 T1289 oasc.ZkController.readConfigName Load collection config from:/collections/control_collection
[junit4:junit4]   2> 285 T1289 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 286 T1289 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 289 T1289 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 344 T1289 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 386 T1289 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 388 T1289 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 392 T1289 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 684 T1289 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 689 T1289 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 691 T1289 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 700 T1289 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 705 T1289 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 709 T1289 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 710 T1289 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 711 T1289 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1347056441586/control/data/
[junit4:junit4]   2> 712 T1289 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@69abb49c
[junit4:junit4]   2> 715 T1289 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1347056441586/control/data/index/
[junit4:junit4]   2> 716 T1289 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1347056441586/control/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 716 T1289 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-1347056441586/control/data/index forceNew:false
[junit4:junit4]   2> 720 T1289 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1347056441586/control/data/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@908d705e; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 721 T1289 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 722 T1289 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 724 T1289 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 724 T1289 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 725 T1289 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 726 T1289 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 727 T1289 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 728 T1289 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 729 T1289 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 730 T1289 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 731 T1289 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 732 T1289 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 732 T1289 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 733 T1289 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 734 T1289 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 735 T1289 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 735 T1289 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 736 T1289 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 737 T1289 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 737 T1289 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 738 T1289 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 739 T1289 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 740 T1289 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 740 T1289 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 741 T1289 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 742 T1289 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 742 T1289 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 743 T1289 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 745 T1289 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 746 T1289 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [OLD_SYNONYMS.TXT, PROTWORDS.TXT, STOPWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, CURRENCY.XML, SCHEMA.XML, SYNONYMS.TXT, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 748 T1289 oass.SolrIndexSearcher.<init> Opening Searcher@af691cd7 main
[junit4:junit4]   2> 749 T1289 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 749 T1289 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 750 T1289 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 754 T1289 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 777 T1312 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@af691cd7 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 780 T1294 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139a2d218f70002 type:create cxid:0x50 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer/queue Error:KeeperErrorCode = NoNode for /solr/overseer/queue
[junit4:junit4]   2> 781 T1289 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 782 T1289 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:45579/solr shardId:control_shard
[junit4:junit4]   2> 783 T1289 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/control_shard/election
[junit4:junit4]   2> 784 T1310 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 785 T1294 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139a2d218f70002 type:create cxid:0x5f zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer/queue-work Error:KeeperErrorCode = NoNode for /solr/overseer/queue-work
[junit4:junit4]   2> 787 T1294 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139a2d218f70002 type:delete cxid:0x6b 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> 788 T1309 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 788 T1289 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process. afterExpiration=false
[junit4:junit4]   2> 790 T1294 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139a2d218f70002 type:create cxid:0x72 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 791 T1289 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:45579/solr/collection1/
[junit4:junit4]   2> 791 T1289 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/control_shard
[junit4:junit4]   2> 793 T1294 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139a2d218f70002 type:create cxid:0x7b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1290 T1310 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 1294 T1309 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 1346 T1289 oasc.ZkController.register We are http://127.0.0.1:45579/solr/collection1/ and leader is http://127.0.0.1:45579/solr/collection1/
[junit4:junit4]   2> 1346 T1289 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:45579/solr
[junit4:junit4]   2> 1347 T1289 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4]   2> 1348 T1289 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 1349 T1289 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4:junit4]   2> 1350 T1289 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 1351 T1289 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 1355 T1289 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 1356 T1289 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:47138
[junit4:junit4]   2> 1357 T1289 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 1358 T1289 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 1358 T1289 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 1367 T1289 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 1367 T1289 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 1368 T1289 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 1368 T1289 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 1369 T1289 oasc.CoreContainer.<init> New CoreContainer -1058168156
[junit4:junit4]   2> 1369 T1289 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 1370 T1289 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 1382 T1289 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 1389 T1289 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:40845/solr
[junit4:junit4]   2> 1390 T1289 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:40845/solr sessionTimeout=8000 watcher=org.apache.solr.common.cloud.ConnectionManager@3468cde8
[junit4:junit4]   2> 1391 T1322 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:40845
[junit4:junit4]   2> 1391 T1289 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 1392 T1322 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:40845, initiating session
[junit4:junit4]   2> 1392 T1291 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:40970
[junit4:junit4]   2> 1392 T1291 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:40970
[junit4:junit4]   2> 1393 T1322 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:40845, sessionid = 0x139a2d218f70003, negotiated timeout = 8000
[junit4:junit4]   2> 1393 T1293 oazs.NIOServerCnxn.finishSessionInit Established session 0x139a2d218f70003 with negotiated timeout 8000 for client /127.0.0.1:40970
[junit4:junit4]   2> 1393 T1323 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@3468cde8 name:ZooKeeperConnection Watcher:127.0.0.1:40845/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 1394 T1289 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 1394 T1294 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139a2d218f70003 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1395 T1294 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139a2d218f70003 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1396 T1289 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:47138_solr
[junit4:junit4]   2> 1396 T1294 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139a2d218f70003 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:47138_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:47138_solr
[junit4:junit4]   2> 1397 T1289 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:47138_solr
[junit4:junit4]   2> 1398 T1309 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 1399 T1289 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 1399 T1289 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 1400 T1289 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 1400 T1289 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 1401 T1289 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 1402 T1289 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 1402 T1289 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 1403 T1289 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 1403 T1289 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 1404 T1289 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 1409 T1289 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 1413 T1289 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 1414 T1289 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 1415 T1289 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 1415 T1289 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 1416 T1289 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 1417 T1289 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 1418 T1289 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 1448 T1289 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 1483 T1289 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 1484 T1289 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 1488 T1289 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 1776 T1289 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 1781 T1289 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 1784 T1289 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 1791 T1289 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 1795 T1289 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 1798 T1310 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 1800 T1289 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 1801 T1309 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 1801 T1323 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 1803 T1289 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 1805 T1289 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1347056441586/jetty1/
[junit4:junit4]   2> 1805 T1289 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@69abb49c
[junit4:junit4]   2> 1806 T1289 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1347056441586/jetty1/index/
[junit4:junit4]   2> 1807 T1289 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1347056441586/jetty1/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 1808 T1289 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-1347056441586/jetty1/index forceNew:false
[junit4:junit4]   2> 1811 T1289 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1347056441586/jetty1/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@b9be3bab; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 1812 T1289 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 1813 T1289 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 1815 T1289 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 1815 T1289 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 1816 T1289 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 1817 T1289 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 1818 T1289 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 1818 T1289 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 1819 T1289 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 1820 T1289 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 1820 T1289 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 1821 T1289 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 1822 T1289 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 1823 T1289 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 1823 T1289 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 1824 T1289 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 1824 T1289 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 1825 T1289 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 1826 T1289 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1827 T1289 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1827 T1289 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1828 T1289 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1829 T1289 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1830 T1289 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1830 T1289 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1831 T1289 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 1832 T1289 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 1833 T1289 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 1834 T1289 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 1835 T1289 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [OLD_SYNONYMS.TXT, PROTWORDS.TXT, STOPWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, CURRENCY.XML, SCHEMA.XML, SYNONYMS.TXT, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 1837 T1289 oass.SolrIndexSearcher.<init> Opening Searcher@8098410e main
[junit4:junit4]   2> 1838 T1289 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 1839 T1289 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 1840 T1289 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 1844 T1289 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 1865 T1324 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@8098410e main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 2305 T1310 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2308 T1309 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 2308 T1323 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 2371 T1289 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 2372 T1289 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:47138/solr shardId:shard1
[junit4:junit4]   2> 2373 T1289 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election
[junit4:junit4]   2> 2376 T1294 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139a2d218f70003 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> 2377 T1289 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process. afterExpiration=false
[junit4:junit4]   2> 2378 T1294 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139a2d218f70003 type:create cxid:0x44 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2379 T1289 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:47138/solr/collection1/
[junit4:junit4]   2> 2379 T1289 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4:junit4]   2> 2382 T1294 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139a2d218f70003 type:create cxid:0x4d zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2810 T1310 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2814 T1309 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 2814 T1323 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 2834 T1289 oasc.ZkController.register We are http://127.0.0.1:47138/solr/collection1/ and leader is http://127.0.0.1:47138/solr/collection1/
[junit4:junit4]   2> 2835 T1289 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:47138/solr
[junit4:junit4]   2> 2836 T1289 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4]   2> 2838 T1289 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2839 T1289 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4:junit4]   2> 2840 T1289 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 2841 T1289 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 2847 T1289 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 2849 T1289 oejs.AbstractConnector.doStart Started SocketConnector@0.0.0.0:44424
[junit4:junit4]   2> 2849 T1289 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 2850 T1289 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 2850 T1289 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 2861 T1289 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 2862 T1289 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 2862 T1289 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 2863 T1289 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 2863 T1289 oasc.CoreContainer.<init> New CoreContainer -981649545
[junit4:junit4]   2> 2864 T1289 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 2865 T1289 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 2876 T1289 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 2886 T1289 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:40845/solr
[junit4:junit4]   2> 2887 T1289 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:40845/solr sessionTimeout=8000 watcher=org.apache.solr.common.cloud.ConnectionManager@6b9f56cb
[junit4:junit4]   2> 2888 T1334 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:40845
[junit4:junit4]   2> 2888 T1289 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 2889 T1291 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:40973
[junit4:junit4]   2> 2889 T1334 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:40845, initiating session
[junit4:junit4]   2> 2890 T1291 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:40973
[junit4:junit4]   2> 2891 T1293 oazs.NIOServerCnxn.finishSessionInit Established session 0x139a2d218f70004 with negotiated timeout 8000 for client /127.0.0.1:40973
[junit4:junit4]   2> 2891 T1334 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:40845, sessionid = 0x139a2d218f70004, negotiated timeout = 8000
[junit4:junit4]   2> 2892 T1335 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6b9f56cb name:ZooKeeperConnection Watcher:127.0.0.1:40845/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 2892 T1289 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 2893 T1294 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139a2d218f70004 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2894 T1294 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139a2d218f70004 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2895 T1289 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:44424_solr
[junit4:junit4]   2> 2896 T1294 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x139a2d218f70004 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:44424_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:44424_solr
[junit4:junit4]   2> 2896 T1289 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:44424_solr
[junit4:junit4]   2> 2898 T1323 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 2898 T1309 oascc.ZkStateReader$3.process Updating live nodes
[junit4:junit4]   2> 2899 T1289 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 2899 T1289 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 2900 T1289 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 2901 T1289 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 2901 T1289 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 2902 T1289 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 2902 T1289 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 2903 T1289 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 2903 T1289 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 2904 T1289 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 2909 T1289 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 2913 T1289 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 2914 T1289 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 2914 T1289 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 2915 T1289 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 2916 T1289 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 2917 T1289 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 2918 T1289 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 2948 T1289 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 2983 T1289 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 2984 T1289 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 2989 T1289 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 3279 T1289 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 3284 T1289 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 3287 T1289 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 3294 T1289 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 3298 T1289 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 3302 T1289 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 3303 T1289 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 3304 T1289 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.cloud.RecoveryZkTest-1347056441586/jetty2/
[junit4:junit4]   2> 3305 T1289 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@69abb49c
[junit4:junit4]   2> 3306 T1289 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=./org.apache.solr.cloud.RecoveryZkTest-1347056441586/jetty2/index/
[junit4:junit4]   2> 3307 T1289 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.RecoveryZkTest-1347056441586/jetty2/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 3307 T1289 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.RecoveryZkTest-1347056441586/jetty2/index forceNew:false
[junit4:junit4]   2> 3311 T1289 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1347056441586/jetty2/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@c49cb0dd; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 3312 T1289 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 3313 T1289 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 3315 T1289 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 3315 T1289 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 3316 T1289 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 3317 T1310 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3317 T1289 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 3318 T1289 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 3319 T1289 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 3320 T1309 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3320 T1323 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3320 T1289 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 3320 T1335 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3321 T1289 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 3322 T1289 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 3323 T1289 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 3323 T1289 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 3324 T1289 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 3325 T1289 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 3325 T1289 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 3326 T1289 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 3327 T1289 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 3328 T1289 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3328 T1289 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3329 T1289 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3330 T1289 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3330 T1289 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3331 T1289 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3332 T1289 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3333 T1289 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 3333 T1289 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 3334 T1289 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 3336 T1289 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 3337 T1289 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [OLD_SYNONYMS.TXT, PROTWORDS.TXT, STOPWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, CURRENCY.XML, SCHEMA.XML, SYNONYMS.TXT, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 3339 T1289 oass.SolrIndexSearcher.<init> Opening Searcher@26861a63 main
[junit4:junit4]   2> 3340 T1289 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 3341 T1289 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 3342 T1289 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 3346 T1289 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 3366 T1336 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@26861a63 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 3822 T1310 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3824 T1309 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3824 T1323 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3824 T1335 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 3870 T1289 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 3872 T1289 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:44424/solr shardId:shard1
[junit4:junit4]   2> 3876 T1289 oasc.ZkController.register We are http://127.0.0.1:44424/solr/collection1/ and leader is http://127.0.0.1:47138/solr/collection1/
[junit4:junit4]   2> 3877 T1289 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:44424/solr
[junit4:junit4]   2> 3878 T1289 oasc.ZkController.checkRecovery Core needs to recover:collection1
[junit4:junit4]   2> 3879 T1289 oasu.DefaultSolrCoreState.doRecovery Running recovery - first canceling any ongoing recovery
[junit4:junit4]   2> ASYNC  NEW_CORE C115 name=collection1 org.apache.solr.core.SolrCore@6d787796 url=http://127.0.0.1:44424/solr/collection1 node=127.0.0.1:44424_solr
[junit4:junit4]   2> 3882 T1337 C115 P44424 oasc.RecoveryStrategy.run Starting recovery process.  core=collection1 recoveringAfterStartup=true
[junit4:junit4]   2> 3883 T1337 C115 P44424 oasc.RecoveryStrategy.doRecovery ###### startupVersions=[]
[junit4:junit4]   2> 3882 T1289 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3884 T1337 C115 P44424 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 3884 T1289 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4:junit4]   2> 3885 T1289 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 3886 T1289 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 3893 T1289 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:40845/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@5efbe23a
[junit4:junit4]   2> 3894 T1338 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:40845
[junit4:junit4]   2> 3894 T1289 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 3895 T1338 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:40845, initiating session
[junit4:junit4]   2> 3895 T1291 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:40976
[junit4:junit4]   2> 3896 T1291 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:40976
[junit4:junit4]   2> 3897 T1338 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:40845, sessionid = 0x139a2d218f70005, negotiated timeout = 10000
[junit4:junit4]   2> 3897 T1293 oazs.NIOServerCnxn.finishSessionInit Established session 0x139a2d218f70005 with negotiated timeout 10000 for client /127.0.0.1:40976
[junit4:junit4]   2> 3898 T1339 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@5efbe23a name:ZooKeeperConnection Watcher:127.0.0.1:40845/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 3898 T1289 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 3899 T1289 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 3901 T1289 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:true cause connection loss:false
[junit4:junit4]   2> 3902 T1289 oascsi.HttpClientUtil.createClient Creating new http client, config:
[junit4:junit4]   2> 3907 T1289 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> ASYNC  NEW_CORE C116 name=collection1 org.apache.solr.core.SolrCore@8fda9e16 url=http://127.0.0.1:45579/solr/collection1 node=127.0.0.1:45579_solr
[junit4:junit4]   2> 4080 T1301 C116 P45579 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1347056441586/control/data/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@908d705e; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 4081 T1301 C116 P45579 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 4084 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[1 (1412491059565428736)]} 0 170
[junit4:junit4]   2> 4084 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10001 (1412491059565428737)]} 0 170
[junit4:junit4]   2> 4136 T1341 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:40845/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@55cb8149
[junit4:junit4]   2> 4137 T1341 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 4137 T1342 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:40845
[junit4:junit4]   2> 4138 T1342 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:40845, initiating session
[junit4:junit4]   2> 4138 T1291 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:40980
[junit4:junit4]   2> 4139 T1291 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:40980
[junit4:junit4]   2> 4140 T1293 oazs.NIOServerCnxn.finishSessionInit Established session 0x139a2d218f70006 with negotiated timeout 10000 for client /127.0.0.1:40980
[junit4:junit4]   2> 4140 T1342 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:40845, sessionid = 0x139a2d218f70006, negotiated timeout = 10000
[junit4:junit4]   2> 4140 T1343 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@55cb8149 name:ZooKeeperConnection Watcher:127.0.0.1:40845/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 4141 T1341 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 4141 T1341 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> ASYNC  NEW_CORE C117 name=collection1 org.apache.solr.core.SolrCore@380576d0 url=http://127.0.0.1:47138/solr/collection1 node=127.0.0.1:47138_solr
[junit4:junit4]   2> 4153 T1316 C117 P47138 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1347056441586/jetty1/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@b9be3bab; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 4154 T1316 C117 P47138 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 4157 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10001 (1412491059641974784)]} 0 6
[junit4:junit4]   2> 4157 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[1 (1412491059643023360)]} 0 5
[junit4:junit4]   2> 4160 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10002 (1412491059650363392)]} 0 1
[junit4:junit4]   2> 4160 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[2 (1412491059651411968)]} 0 0
[junit4:junit4]   2> 4162 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10002 (1412491059653509120)]} 0 0
[junit4:junit4]   2> 4163 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[2 (1412491059653509121)]} 0 1
[junit4:junit4]   2> 4165 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10003 (1412491059656654848)]} 0 1
[junit4:junit4]   2> 4165 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[3 (1412491059656654849)]} 0 0
[junit4:junit4]   2> 4168 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10003 (1412491059659800576)]} 0 1
[junit4:junit4]   2> 4169 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[3 (1412491059659800577)]} 0 1
[junit4:junit4]   2> 4170 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10004 (1412491059661897728)]} 0 0
[junit4:junit4]   2> 4171 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[4 (1412491059662946304)]} 0 0
[junit4:junit4]   2> 4173 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10004 (1412491059665043456)]} 0 1
[junit4:junit4]   2> 4174 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[4 (1412491059665043457)]} 0 1
[junit4:junit4]   2> 4176 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10005 (1412491059667140608)]} 0 1
[junit4:junit4]   2> 4178 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10005 (1412491059670286336)]} 0 0
[junit4:junit4]   2> 4182 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10006 (1412491059673432064)]} 0 1
[junit4:junit4]   2> 4183 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[5 (1412491059668189184)]} 0 7
[junit4:junit4]   2> 4185 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10006 (1412491059676577792)]} 0 1
[junit4:junit4]   2> 4186 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[5 (1412491059677626368)]} 0 1
[junit4:junit4]   2> 4187 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[10004 (-1412491059679723520)]} 0 0
[junit4:junit4]   2> 4189 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[6 (1412491059680772096)]} 0 1
[junit4:junit4]   2> 4190 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[10004 (-1412491059682869248)]} 0 1
[junit4:junit4]   2> 4191 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[6 (1412491059683917824)]} 0 0
[junit4:junit4]   2> 4192 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10007 (1412491059684966400)]} 0 0
[junit4:junit4]   2> 4193 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[4 (-1412491059686014976)]} 0 0
[junit4:junit4]   2> 4195 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10007 (1412491059687063552)]} 0 1
[junit4:junit4]   2> 4196 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[4 (-1412491059689160704)]} 0 0
[junit4:junit4]   2> 4197 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[10007 (-1412491059690209280)]} 0 0
[junit4:junit4]   2> 4198 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[7 (1412491059691257856)]} 0 0
[junit4:junit4]   2> 4199 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[10007 (-1412491059692306432)]} 0 0
[junit4:junit4]   2> 4201 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[7 (1412491059693355008)]} 0 1
[junit4:junit4]   2> 4202 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10008 (1412491059695452160)]} 0 0
[junit4:junit4]   2> 4203 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[7 (-1412491059696500736)]} 0 0
[junit4:junit4]   2> 4205 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[7 (-1412491059698597888)]} 0 0
[junit4:junit4]   2> 4207 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[8 (1412491059700695040)]} 0 0
[junit4:junit4]   2> 4210 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[8 (1412491059703840768)]} 0 0
[junit4:junit4]   2> 4211 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10008 (1412491059697549312)]} 0 7
[junit4:junit4]   2> 4213 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[9 (1412491059706986496)]} 0 1
[junit4:junit4]   2> 4214 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10009 (1412491059708035072)]} 0 0
[junit4:junit4]   2> 4216 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[9 (1412491059709083648)]} 0 1
[junit4:junit4]   2> 4217 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10009 (1412491059710132224)]} 0 1
[junit4:junit4]   2> 4219 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10 (1412491059713277952)]} 0 0
[junit4:junit4]   2> 4222 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10 (1412491059715375104)]} 0 1
[junit4:junit4]   2> 4242 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[11 (1412491059718520832)]} 0 18
[junit4:junit4]   2> 4244 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10010 (1412491059713277953)]} 0 25
[junit4:junit4]   2> 4245 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[11 (1412491059740540928)]} 0 1
[junit4:junit4]   2> 4247 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10010 (1412491059741589504)]} 0 1
[junit4:junit4]   2> 4248 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[12 (1412491059742638080)]} 0 1
[junit4:junit4]   2> 4250 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10011 (1412491059744735232)]} 0 1
[junit4:junit4]   2> 4250 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[12 (1412491059745783808)]} 0 0
[junit4:junit4]   2> 4253 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[13 (1412491059748929536)]} 0 1
[junit4:junit4]   2> 4256 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[13 (1412491059751026688)]} 0 1
[junit4:junit4]   2> 4258 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[14 (1412491059754172416)]} 0 0
[junit4:junit4]   2> 4261 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10011 (1412491059747880960)]} 0 9
[junit4:junit4]   2> 4261 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[14 (1412491059757318144)]} 0 0
[junit4:junit4]   2> 4263 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10012 (1412491059759415296)]} 0 0
[junit4:junit4]   2> 4264 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[15 (1412491059760463872)]} 0 0
[junit4:junit4]   2> 4266 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10012 (1412491059762561024)]} 0 0
[junit4:junit4]   2> 4267 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[15 (1412491059762561025)]} 0 1
[junit4:junit4]   2> 4269 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10013 (1412491059764658176)]} 0 1
[junit4:junit4]   2> 4270 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[13 (-1412491059765706752)]} 0 1
[junit4:junit4]   2> 4272 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10013 (1412491059767803904)]} 0 1
[junit4:junit4]   2> 4272 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[13 (-1412491059768852480)]} 0 0
[junit4:junit4]   2> 4274 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10014 (1412491059770949632)]} 0 0
[junit4:junit4]   2> 4277 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10014 (1412491059774095360)]} 0 0
[junit4:junit4]   2> 4281 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10015 (1412491059777241088)]} 0 2
[junit4:junit4]   2> 4284 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10015 (1412491059780386816)]} 0 1
[junit4:junit4]   2> 4285 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[16 (1412491059770949633)]} 0 11
[junit4:junit4]   2> 4286 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10013 (-1412491059783532544)]} 0 0
[junit4:junit4]   2> 4287 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[16 (1412491059784581120)]} 0 0
[junit4:junit4]   2> 4288 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[10013 (-1412491059785629696)]} 0 0
[junit4:junit4]   2> 4290 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[14 (-1412491059786678272)]} 0 1
[junit4:junit4]   2> 4291 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10016 (1412491059787726848)]} 0 1
[junit4:junit4]   2> 4292 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[14 (-1412491059789824000)]} 0 0
[junit4:junit4]   2> 4294 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[17 (1412491059791921152)]} 0 0
[junit4:junit4]   2> 4298 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[17 (1412491059795066880)]} 0 1
[junit4:junit4]   2> 4303 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[18 (1412491059800309760)]} 0 1
[junit4:junit4]   2> 4306 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[18 (1412491059803455488)]} 0 1
[junit4:junit4]   2> 4306 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10016 (1412491059790872576)]} 0 13
[junit4:junit4]   2> 4308 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10014 (-1412491059806601217)]} 0 0
[junit4:junit4]   2> 4308 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[19 (1412491059806601216)]} 0 0
[junit4:junit4]   2> 4310 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10014 (-1412491059808698368)]} 0 0
[junit4:junit4]   2> 4311 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[19 (1412491059809746944)]} 0 1
[junit4:junit4]   2> 4312 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10017 (1412491059810795520)]} 0 0
[junit4:junit4]   2> 4313 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[20 (1412491059811844096)]} 0 0
[junit4:junit4]   2> 4315 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10017 (1412491059812892672)]} 0 1
[junit4:junit4]   2> 4316 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[20 (1412491059813941248)]} 0 1
[junit4:junit4]   2> 4317 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10018 (1412491059816038400)]} 0 0
[junit4:junit4]   2> 4318 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[21 (1412491059817086976)]} 0 0
[junit4:junit4]   2> 4319 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10018 (1412491059818135552)]} 0 0
[junit4:junit4]   2> 4320 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[21 (1412491059819184128)]} 0 0
[junit4:junit4]   2> 4324 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[22 (1412491059822329856)]} 0 1
[junit4:junit4]   2> 4327 T1310 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 4326 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[22 (1412491059825475584)]} 0 0
[junit4:junit4]   2> 4329 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10019 (1412491059820232704)]} 0 8
[junit4:junit4]   2> 4329 T1309 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4329 T1335 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4330 T1343 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4329 T1323 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4330 T1339 oascc.ZkStateReader$2.process A cluster state change has occurred - updating...
[junit4:junit4]   2> 4329 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[16 (-1412491059828621312)]} 0 0
[junit4:junit4]   2>  C115_STATE=coll:collection1 core:collection1 props:{state=recovering, base_url=http://127.0.0.1:44424/solr, node_name=127.0.0.1:44424_solr, roles=null, shard=shard1, collection=collection1, core=collection1}
[junit4:junit4]   2> 4341 T1327 C115 P44424 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.cloud.RecoveryZkTest-1347056441586/jetty2/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@c49cb0dd; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 4342 T1327 C115 P44424 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 4343 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=3 
[junit4:junit4]   2> 4343 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[16 (-1412491059832815616)]} 0 11
[junit4:junit4]   2> 4344 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=3 
[junit4:junit4]   2> 4345 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10019 (1412491059831767040)]} 0 14
[junit4:junit4]   2> 4346 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[23 (1412491059845398528)]} 0 1
[junit4:junit4]   2> 4347 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10020 (1412491059846447104)]} 0 1
[junit4:junit4]   2> 4351 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4352 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10020 (1412491059849592832)]} 0 4
[junit4:junit4]   2> 4354 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10021 (1412491059854835712)]} 0 0
[junit4:junit4]   2> 4355 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4356 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[23 (1412491059847495680)]} 0 9
[junit4:junit4]   2> 4358 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[24 (1412491059859030016)]} 0 0
[junit4:junit4]   2> 4358 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4359 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10021 (1412491059856932864)]} 0 3
[junit4:junit4]   2> 4361 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10022 (1412491059862175744)]} 0 0
[junit4:junit4]   2> 4362 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4363 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[24 (1412491059861127168)]} 0 3
[junit4:junit4]   2> 4365 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[25 (1412491059866370048)]} 0 0
[junit4:junit4]   2> 4366 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4366 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10022 (1412491059864272896)]} 0 3
[junit4:junit4]   2> 4368 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[10016 (-1412491059869515776)]} 0 0
[junit4:junit4]   2> 4369 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4370 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[25 (1412491059868467200)]} 0 3
[junit4:junit4]   2> 4372 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4372 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10016 (-1412491059871612928)]} 0 2
[junit4:junit4]   2> 4373 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[26 (1412491059873710080)]} 0 1
[junit4:junit4]   2> 4374 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10023 (1412491059875807232)]} 0 0
[junit4:junit4]   2> 4377 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4377 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[26 (1412491059876855808)]} 0 3
[junit4:junit4]   2> 4379 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4379 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10023 (1412491059877904384)]} 0 3
[junit4:junit4]   2> 4379 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[18 (-1412491059881050112)]} 0 0
[junit4:junit4]   2> 4383 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4384 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[18 (-1412491059883147264)]} 0 3
[junit4:junit4]   2> 4387 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[27 (1412491059888390144)]} 0 1
[junit4:junit4]   2> 4387 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10024 (1412491059883147264)]} 0 6
[junit4:junit4]   2> 4392 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4393 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10024 (1412491059891535873)]} 0 4
[junit4:junit4]   2> 4396 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10025 (1412491059897827328)]} 0 1
[junit4:junit4]   2> 4397 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=7 
[junit4:junit4]   2> 4398 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[27 (1412491059891535872)]} 0 10
[junit4:junit4]   2> 4400 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[19 (-1412491059903070208)]} 0 0
[junit4:junit4]   2> 4400 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4401 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10025 (1412491059900973056)]} 0 3
[junit4:junit4]   2> 4404 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10026 (1412491059906215936)]} 0 1
[junit4:junit4]   2> 4404 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4405 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[19 (-1412491059905167360)]} 0 3
[junit4:junit4]   2> 4407 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[28 (1412491059910410240)]} 0 0
[junit4:junit4]   2> 4408 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4409 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10026 (1412491059909361664)]} 0 3
[junit4:junit4]   2> 4411 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[10018 (-1412491059914604544)]} 0 0
[junit4:junit4]   2> 4411 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4412 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[28 (1412491059912507392)]} 0 3
[junit4:junit4]   2> 4414 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[22 (-1412491059917750272)]} 0 0
[junit4:junit4]   2> 4414 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4415 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10018 (-1412491059916701696)]} 0 2
[junit4:junit4]   2> 4417 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10027 (1412491059920896000)]} 0 0
[junit4:junit4]   2> 4417 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4418 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[22 (-1412491059919847424)]} 0 2
[junit4:junit4]   2> 4420 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[29 (1412491059924041728)]} 0 0
[junit4:junit4]   2> 4424 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4425 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[29 (1412491059926138880)]} 0 3
[junit4:junit4]   2> 4427 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4427 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10027 (1412491059922993152)]} 0 8
[junit4:junit4]   2> 4427 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[30 (1412491059931381760)]} 0 0
[junit4:junit4]   2> 4429 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10019 (-1412491059933478912)]} 0 0
[junit4:junit4]   2> 4432 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4432 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[30 (1412491059933478912)]} 0 3
[junit4:junit4]   2> 4432 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4433 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[10019 (-1412491059935576064)]} 0 2
[junit4:junit4]   2> 4434 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[23 (-1412491059938721792)]} 0 0
[junit4:junit4]   2> 4435 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10028 (1412491059939770368)]} 0 0
[junit4:junit4]   2> 4437 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4438 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[23 (-1412491059940818944)]} 0 2
[junit4:junit4]   2> 4439 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4440 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10028 (1412491059941867520)]} 0 3
[junit4:junit4]   2> 4440 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[31 (1412491059945013248)]} 0 0
[junit4:junit4]   2> 4442 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10022 (-1412491059947110400)]} 0 1
[junit4:junit4]   2> 4444 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4445 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[31 (1412491059947110400)]} 0 3
[junit4:junit4]   2> 4445 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4446 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[10022 (-1412491059948158976)]} 0 3
[junit4:junit4]   2> 4448 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10029 (1412491059952353281)]} 0 1
[junit4:junit4]   2> 4453 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[32 (1412491059952353280)]} 0 7
[junit4:junit4]   2> 4458 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4459 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=7 
[junit4:junit4]   2> 4459 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[32 (1412491059960741888)]} 0 4
[junit4:junit4]   2> 4459 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10029 (1412491059955499008)]} 0 9
[junit4:junit4]   2> 4461 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[24 (-1412491059967033344)]} 0 0
[junit4:junit4]   2> 4462 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10030 (1412491059967033345)]} 0 1
[junit4:junit4]   2> 4465 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4465 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[24 (-1412491059969130496)]} 0 2
[junit4:junit4]   2> 4466 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4467 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10030 (1412491059970179072)]} 0 3
[junit4:junit4]   2> 4468 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[33 (1412491059973324800)]} 0 1
[junit4:junit4]   2> 4469 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10023 (-1412491059975421952)]} 0 0
[junit4:junit4]   2> 4472 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4472 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4473 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[10023 (-1412491059977519104)]} 0 2
[junit4:junit4]   2> 4473 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[33 (1412491059976470528)]} 0 4
[junit4:junit4]   2> 4475 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10031 (1412491059981713408)]} 0 0
[junit4:junit4]   2> 4476 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[25 (-1412491059981713409)]} 0 1
[junit4:junit4]   2> 4479 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4480 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4480 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[25 (-1412491059984859137)]} 0 2
[junit4:junit4]   2> 4481 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10031 (1412491059984859136)]} 0 3
[junit4:junit4]   2> 4483 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[34 (1412491059990102016)]} 0 1
[junit4:junit4]   2> 4483 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10032 (1412491059990102017)]} 0 0
[junit4:junit4]   2> 4489 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4489 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4490 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[34 (1412491059993247745)]} 0 4
[junit4:junit4]   2> 4490 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10032 (1412491059993247744)]} 0 4
[junit4:junit4]   2> 4492 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[35 (1412491059999539200)]} 0 0
[junit4:junit4]   2> 4493 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[10024 (-1412491060000587776)]} 0 1
[junit4:junit4]   2> 4497 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4497 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4498 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[35 (1412491060001636352)]} 0 4
[junit4:junit4]   2> 4498 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10024 (-1412491060002684928)]} 0 3
[junit4:junit4]   2> 4500 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[36 (1412491060007927808)]} 0 0
[junit4:junit4]   2> 4501 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10033 (1412491060007927809)]} 0 1
[junit4:junit4]   2> 4508 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4509 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[36 (1412491060010024960)]} 0 7
[junit4:junit4]   2> 4512 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[27 (-1412491060020510720)]} 0 0
[junit4:junit4]   2> 4516 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4516 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4516 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10033 (1412491060014219264)]} 0 10
[junit4:junit4]   2> 4517 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[27 (-1412491060022607872)]} 0 3
[junit4:junit4]   2> 4519 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10025 (-1412491060027850752)]} 0 1
[junit4:junit4]   2> 4526 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[37 (1412491060027850753)]} 0 7
[junit4:junit4]   2> 4526 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4527 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10025 (-1412491060029947904)]} 0 7
[junit4:junit4]   2> 4530 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10034 (1412491060038336512)]} 0 1
[junit4:junit4]   2> 4538 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=8 
[junit4:junit4]   2> 4539 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[37 (1412491060037287936)]} 0 11
[junit4:junit4]   2> 4541 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[38 (1412491060050919424)]} 0 0
[junit4:junit4]   2> 4542 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4543 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10034 (1412491060041482240)]} 0 11
[junit4:junit4]   2> 4546 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10035 (1412491060055113728)]} 0 1
[junit4:junit4]   2> 4547 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4548 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[38 (1412491060054065152)]} 0 5
[junit4:junit4]   2> 4551 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[39 (1412491060060356608)]} 0 1
[junit4:junit4]   2> 4551 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4552 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10035 (1412491060058259456)]} 0 4
[junit4:junit4]   2> 4554 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10036 (1412491060064550912)]} 0 0
[junit4:junit4]   2> 4555 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4556 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[39 (1412491060063502336)]} 0 3
[junit4:junit4]   2> 4558 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[40 (1412491060067696640)]} 0 1
[junit4:junit4]   2> 4558 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4559 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10036 (1412491060066648064)]} 0 3
[junit4:junit4]   2> 4561 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[10027 (-1412491060071890944)]} 0 0
[junit4:junit4]   2> 4562 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4563 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[40 (1412491060070842368)]} 0 3
[junit4:junit4]   2> 4565 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4565 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[32 (-1412491060076085248)]} 0 0
[junit4:junit4]   2> 4566 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10027 (-1412491060073988096)]} 0 3
[junit4:junit4]   2> 4568 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10037 (1412491060079230976)]} 0 0
[junit4:junit4]   2> 4569 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4570 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[32 (-1412491060078182400)]} 0 3
[junit4:junit4]   2> 4572 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[41 (1412491060082376704)]} 0 1
[junit4:junit4]   2> 4572 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4573 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10037 (1412491060081328128)]} 0 3
[junit4:junit4]   2> 4576 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4576 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10038 (1412491060087619584)]} 0 0
[junit4:junit4]   2> 4577 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[41 (1412491060085522432)]} 0 4
[junit4:junit4]   2> 4579 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[33 (-1412491060090765312)]} 0 0
[junit4:junit4]   2> 4581 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4581 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10038 (1412491060090765312)]} 0 3
[junit4:junit4]   2> 4583 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4584 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[33 (-1412491060092862464)]} 0 3
[junit4:junit4]   2> 4587 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[42 (1412491060098105344)]} 0 1
[junit4:junit4]   2> 4596 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=5 
[junit4:junit4]   2> 4597 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[42 (1412491060101251072)]} 0 8
[junit4:junit4]   2> 4600 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[34 (-1412491060111736832)]} 0 1
[junit4:junit4]   2> 4601 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10039 (1412491060094959616)]} 0 18
[junit4:junit4]   2> 4603 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4604 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[34 (-1412491060114882560)]} 0 2
[junit4:junit4]   2> 4606 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4607 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[43 (1412491060119076864)]} 0 1
[junit4:junit4]   2> 4607 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10039 (1412491060115931136)]} 0 4
[junit4:junit4]   2> 4609 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10040 (1412491060122222592)]} 0 0
[junit4:junit4]   2> 4613 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4614 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[43 (1412491060122222592)]} 0 5
[junit4:junit4]   2> 4616 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4617 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[44 (1412491060130611200)]} 0 0
[junit4:junit4]   2> 4617 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10040 (1412491060125368320)]} 0 5
[junit4:junit4]   2> 4621 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10032 (-1412491060134805504)]} 0 0
[junit4:junit4]   2> 4624 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4625 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[44 (1412491060134805504)]} 0 4
[junit4:junit4]   2> 4627 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4627 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[45 (1412491060141096960)]} 0 0
[junit4:junit4]   2> 4628 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[10032 (-1412491060137951232)]} 0 5
[junit4:junit4]   2> 4630 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10041 (1412491060144242688)]} 0 0
[junit4:junit4]   2> 4632 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4633 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[45 (1412491060144242688)]} 0 3
[junit4:junit4]   2> 4635 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[46 (1412491060149485568)]} 0 0
[junit4:junit4]   2> 4635 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4636 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10041 (1412491060147388416)]} 0 4
[junit4:junit4]   2> 4639 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10033 (-1412491060153679872)]} 0 0
[junit4:junit4]   2> 4640 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4640 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[46 (1412491060151582720)]} 0 3
[junit4:junit4]   2> 4643 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4643 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[47 (1412491060157874176)]} 0 0
[junit4:junit4]   2> 4644 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[10033 (-1412491060155777024)]} 0 3
[junit4:junit4]   2> 4646 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10042 (1412491060161019904)]} 0 0
[junit4:junit4]   2> 4653 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4654 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10042 (1412491060163117056)]} 0 6
[junit4:junit4]   2> 4656 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10034 (-1412491060171505664)]} 0 0
[junit4:junit4]   2> 4660 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4661 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[10034 (-1412491060173602816)]} 0 3
[junit4:junit4]   2> 4667 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4668 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[47 (1412491060161019904)]} 0 22
[junit4:junit4]   2> 4671 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[48 (1412491060186185728)]} 0 1
[junit4:junit4]   2> 4674 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10043 (1412491060178845696)]} 0 11
[junit4:junit4]   2> 4685 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=8 
[junit4:junit4]   2> 4686 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[48 (1412491060190380032)]} 0 13
[junit4:junit4]   2> 4688 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[35 (-1412491060205060096)]} 0 0
[junit4:junit4]   2> 4689 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4690 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10043 (1412491060193525760)]} 0 13
[junit4:junit4]   2> 4692 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4693 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10044 (1412491060209254400)]} 0 1
[junit4:junit4]   2> 4693 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[35 (-1412491060208205824)]} 0 3
[junit4:junit4]   2> 4695 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[49 (1412491060212400128)]} 0 0
[junit4:junit4]   2> 4698 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4698 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10044 (1412491060212400128)]} 0 3
[junit4:junit4]   2> 4700 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4700 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[49 (1412491060215545856)]} 0 3
[junit4:junit4]   2> 4701 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10045 (1412491060217643008)]} 0 1
[junit4:junit4]   2> 4703 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[36 (-1412491060220788736)]} 0 1
[junit4:junit4]   2> 4706 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4707 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4707 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[36 (-1412491060221837312)]} 0 3
[junit4:junit4]   2> 4707 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10045 (1412491060220788736)]} 0 4
[junit4:junit4]   2> 4709 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[50 (1412491060227080192)]} 0 0
[junit4:junit4]   2> 4710 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10046 (1412491060227080193)]} 0 1
[junit4:junit4]   2> 4714 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4714 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4714 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10046 (1412491060230225921)]} 0 2
[junit4:junit4]   2> 4715 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[50 (1412491060230225920)]} 0 3
[junit4:junit4]   2> 4717 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10047 (1412491060235468800)]} 0 1
[junit4:junit4]   2> 4717 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[37 (-1412491060235468801)]} 0 0
[junit4:junit4]   2> 4721 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4721 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[37 (-1412491060237565953)]} 0 2
[junit4:junit4]   2> 4724 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[51 (1412491060241760256)]} 0 1
[junit4:junit4]   2> 4724 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4725 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10047 (1412491060237565952)]} 0 6
[junit4:junit4]   2> 4727 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10048 (1412491060245954560)]} 0 0
[junit4:junit4]   2> 4728 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4729 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[51 (1412491060244905984)]} 0 3
[junit4:junit4]   2> 4732 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4732 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10048 (1412491060248051712)]} 0 3
[junit4:junit4]   2> 4735 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10035 (-1412491060254343168)]} 0 0
[junit4:junit4]   2> 4738 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[52 (1412491060250148864)]} 0 7
[junit4:junit4]   2> 4739 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4739 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10035 (-1412491060256440320)]} 0 2
[junit4:junit4]   2> 4742 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10049 (1412491060261683200)]} 0 1
[junit4:junit4]   2> 4748 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 4748 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10049 (1412491060264828928)]} 0 3
[junit4:junit4]   2> 4750 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=8 
[junit4:junit4]   2> 4751 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[10036 (-1412491060271120384)]} 0 0
[junit4:junit4]   2> 4751 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[52 (1412491060259586048)]} 0 11
[junit4:junit4]   2> 4754 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[53 (1412491060273217536)]} 0 1
[junit4:junit4]   2> 4754 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4755 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10036 (-1412491060273217536)]} 0 2
[junit4:junit4]   2> 4758 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10050 (1412491060277411840)]} 0 1
[junit4:junit4]   2> 4758 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4759 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[53 (1412491060276363264)]} 0 4
[junit4:junit4]   2> 4762 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[54 (1412491060281606144)]} 0 1
[junit4:junit4]   2> 4762 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4763 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10050 (1412491060280557568)]} 0 3
[junit4:junit4]   2> 4765 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[10037 (-1412491060285800448)]} 0 1
[junit4:junit4]   2> 4766 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4766 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[54 (1412491060284751872)]} 0 2
[junit4:junit4]   2> 4769 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4769 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[55 (1412491060288946176)]} 0 1
[junit4:junit4]   2> 4775 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10037 (-1412491060286849024)]} 0 9
[junit4:junit4]   2> 4778 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10051 (1412491060298383360)]} 0 1
[junit4:junit4]   2> 4780 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4781 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[55 (1412491060298383360)]} 0 4
[junit4:junit4]   2> 4783 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[39 (-1412491060304674816)]} 0 0
[junit4:junit4]   2> 4783 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4784 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10051 (1412491060301529088)]} 0 4
[junit4:junit4]   2> 4786 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4786 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10052 (1412491060307820544)]} 0 0
[junit4:junit4]   2> 4787 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[39 (-1412491060306771968)]} 0 2
[junit4:junit4]   2> 4790 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[56 (1412491060310966272)]} 0 1
[junit4:junit4]   2> 4794 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4796 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[56 (1412491060314112000)]} 0 4
[junit4:junit4]   2> 4799 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4799 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[57 (1412491060320403456)]} 0 1
[junit4:junit4]   2> 4800 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10052 (1412491060310966272)]} 0 11
[junit4:junit4]   2> 4804 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4805 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[57 (1412491060324597760)]} 0 4
[junit4:junit4]   2> 4808 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10053 (1412491060324597760)]} 0 6
[junit4:junit4]   2> 4808 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[58 (1412491060329840640)]} 0 1
[junit4:junit4]   2> 4820 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4821 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10053 (1412491060332986368)]} 0 11
[junit4:junit4]   2> 4823 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=7 
[junit4:junit4]   2> 4824 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[58 (1412491060336132096)]} 0 11
[junit4:junit4]   2> 4824 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10054 (1412491060347666432)]} 0 0
[junit4:junit4]   2> 4826 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[59 (1412491060349763584)]} 0 0
[junit4:junit4]   2> 4829 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4830 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10054 (1412491060350812160)]} 0 3
[junit4:junit4]   2> 4832 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4832 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10055 (1412491060356055040)]} 0 0
[junit4:junit4]   2> 4832 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[59 (1412491060351860736)]} 0 4
[junit4:junit4]   2> 4835 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[60 (1412491060359200768)]} 0 0
[junit4:junit4]   2> 4837 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4837 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10055 (1412491060358152192)]} 0 3
[junit4:junit4]   2> 4839 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[10039 (-1412491060363395072)]} 0 0
[junit4:junit4]   2> 4840 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4840 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[60 (1412491060362346496)]} 0 2
[junit4:junit4]   2> 4843 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4843 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[43 (-1412491060367589376)]} 0 0
[junit4:junit4]   2> 4843 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10039 (-1412491060365492224)]} 0 2
[junit4:junit4]   2> 4846 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10056 (1412491060370735104)]} 0 0
[junit4:junit4]   2> 4847 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4848 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[43 (-1412491060369686528)]} 0 3
[junit4:junit4]   2> 4850 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[61 (1412491060374929408)]} 0 0
[junit4:junit4]   2> 4850 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4852 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10056 (1412491060372832256)]} 0 4
[junit4:junit4]   2> 4854 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10057 (1412491060379123712)]} 0 0
[junit4:junit4]   2> 4855 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4855 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[61 (1412491060377026560)]} 0 3
[junit4:junit4]   2> 4858 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[62 (1412491060383318016)]} 0 0
[junit4:junit4]   2> 4858 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4859 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10057 (1412491060381220864)]} 0 3
[junit4:junit4]   2> 4864 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4868 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[62 (1412491060385415168)]} 0 8
[junit4:junit4]   2> 4868 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10058 (1412491060386463744)]} 0 7
[junit4:junit4]   2> 4870 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[47 (-1412491060395900928)]} 0 0
[junit4:junit4]   2> 4874 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4876 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[47 (-1412491060397998080)]} 0 4
[junit4:junit4]   2> 4881 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[63 (1412491060406386688)]} 0 1
[junit4:junit4]   2> 4887 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4888 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[63 (1412491060410580992)]} 0 4
[junit4:junit4]   2> 4890 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=18 
[junit4:junit4]   2> 4890 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[64 (1412491060416872448)]} 0 0
[junit4:junit4]   2> 4891 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10058 (1412491060395900928)]} 0 21
[junit4:junit4]   2> 4893 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10059 (1412491060420018176)]} 0 0
[junit4:junit4]   2> 4895 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4896 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[64 (1412491060420018176)]} 0 3
[junit4:junit4]   2> 4898 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4898 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[65 (1412491060425261056)]} 0 0
[junit4:junit4]   2> 4899 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10059 (1412491060422115328)]} 0 4
[junit4:junit4]   2> 4902 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10060 (1412491060429455360)]} 0 0
[junit4:junit4]   2> 4903 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4904 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[65 (1412491060428406784)]} 0 3
[junit4:junit4]   2> 4906 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[48 (-1412491060433649664)]} 0 1
[junit4:junit4]   2> 4908 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4908 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10060 (1412491060431552512)]} 0 4
[junit4:junit4]   2> 4909 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4910 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[48 (-1412491060435746816)]} 0 2
[junit4:junit4]   2> 4911 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10043 (-1412491060438892544)]} 0 1
[junit4:junit4]   2> 4913 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[66 (1412491060440989696)]} 0 0
[junit4:junit4]   2> 4915 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4915 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10043 (-1412491060440989696)]} 0 2
[junit4:junit4]   2> 4918 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4918 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10061 (1412491060446232576)]} 0 1
[junit4:junit4]   2> 4919 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[66 (1412491060444135424)]} 0 3
[junit4:junit4]   2> 4928 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4928 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[67 (1412491060450426880)]} 0 6
[junit4:junit4]   2> 4930 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10061 (1412491060449378304)]} 0 9
[junit4:junit4]   2> 4932 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10062 (1412491060460912640)]} 0 0
[junit4:junit4]   2> 4934 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4935 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[67 (1412491060459864064)]} 0 4
[junit4:junit4]   2> 4946 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[68 (1412491060466155520)]} 0 9
[junit4:junit4]   2> 4946 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4947 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10062 (1412491060463009792)]} 0 13
[junit4:junit4]   2> 4951 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10047 (-1412491060480835584)]} 0 1
[junit4:junit4]   2> 4955 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4957 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10047 (-1412491060483981312)]} 0 3
[junit4:junit4]   2> 4960 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10063 (1412491060489224192)]} 0 1
[junit4:junit4]   2> 4966 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=9 
[junit4:junit4]   2> 4967 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[68 (1412491060477689856)]} 0 19
[junit4:junit4]   2> 4968 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4968 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10063 (1412491060492369920)]} 0 6
[junit4:junit4]   2> 4969 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[69 (1412491060499709952)]} 0 0
[junit4:junit4]   2> 4971 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10064 (1412491060501807104)]} 0 0
[junit4:junit4]   2> 4973 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4974 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[69 (1412491060501807104)]} 0 3
[junit4:junit4]   2> 4976 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[49 (-1412491060507049984)]} 0 0
[junit4:junit4]   2> 4976 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4977 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10064 (1412491060503904256)]} 0 4
[junit4:junit4]   2> 4980 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 4980 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10065 (1412491060511244288)]} 0 1
[junit4:junit4]   2> 4980 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[49 (-1412491060509147136)]} 0 2
[junit4:junit4]   2> 4984 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[70 (1412491060515438592)]} 0 1
[junit4:junit4]   2> 4985 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4986 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10065 (1412491060514390016)]} 0 3
[junit4:junit4]   2> 4988 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[10048 (-1412491060519632896)]} 0 0
[junit4:junit4]   2> 4990 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4991 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[70 (1412491060517535744)]} 0 5
[junit4:junit4]   2> 4992 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4993 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10048 (-1412491060522778624)]} 0 2
[junit4:junit4]   2> 4993 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[50 (-1412491060524875776)]} 0 0
[junit4:junit4]   2> 4995 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10066 (1412491060526972928)]} 0 0
[junit4:junit4]   2> 4998 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 4999 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[50 (-1412491060526972928)]} 0 4
[junit4:junit4]   2> 5000 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5001 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[71 (1412491060532215808)]} 0 1
[junit4:junit4]   2> 5001 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10066 (1412491060530118656)]} 0 3
[junit4:junit4]   2> 5004 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10067 (1412491060535361536)]} 0 1
[junit4:junit4]   2> 5007 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5008 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[71 (1412491060535361536)]} 0 5
[junit4:junit4]   2> 5009 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5010 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[51 (-1412491060542701568)]} 0 0
[junit4:junit4]   2> 5011 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10067 (1412491060538507264)]} 0 5
[junit4:junit4]   2> 5013 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10068 (1412491060545847296)]} 0 0
[junit4:junit4]   2> 5013 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5014 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[51 (-1412491060544798720)]} 0 2
[junit4:junit4]   2> 5017 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5018 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10068 (1412491060547944448)]} 0 3
[junit4:junit4]   2> 5023 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10069 (1412491060555284480)]} 0 2
[junit4:junit4]   2> 5027 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[72 (1412491060548993024)]} 0 11
[junit4:junit4]   2> 5034 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5035 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=8 
[junit4:junit4]   2> 5035 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[72 (1412491060563673088)]} 0 5
[junit4:junit4]   2> 5036 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10069 (1412491060558430208)]} 0 11
[junit4:junit4]   2> 5038 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[52 (-1412491060572061696)]} 0 1
[junit4:junit4]   2> 5038 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[10049 (-1412491060572061697)]} 0 0
[junit4:junit4]   2> 5042 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5043 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5044 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10049 (-1412491060574158849)]} 0 4
[junit4:junit4]   2> 5044 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[52 (-1412491060574158848)]} 0 4
[junit4:junit4]   2> 5046 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10070 (1412491060580450304)]} 0 0
[junit4:junit4]   2> 5047 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[73 (1412491060580450305)]} 0 1
[junit4:junit4]   2> 5051 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5052 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5053 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10070 (1412491060584644608)]} 0 3
[junit4:junit4]   2> 5053 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[73 (1412491060583596032)]} 0 4
[junit4:junit4]   2> 5055 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10050 (-1412491060589887488)]} 0 1
[junit4:junit4]   2> 5055 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[54 (-1412491060589887489)]} 0 0
[junit4:junit4]   2> 5059 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5059 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5059 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10050 (-1412491060591984640)]} 0 2
[junit4:junit4]   2> 5060 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[54 (-1412491060591984641)]} 0 3
[junit4:junit4]   2> 5063 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10071 (1412491060597227520)]} 0 1
[junit4:junit4]   2> 5064 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[74 (1412491060599324672)]} 0 0
[junit4:junit4]   2> 5068 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5068 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10071 (1412491060600373248)]} 0 3
[junit4:junit4]   2> 5070 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5070 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[74 (1412491060602470400)]} 0 4
[junit4:junit4]   2> 5070 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10051 (-1412491060605616128)]} 0 0
[junit4:junit4]   2> 5072 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[56 (-1412491060607713280)]} 0 0
[junit4:junit4]   2> 5075 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5075 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10051 (-1412491060608761856)]} 0 2
[junit4:junit4]   2> 5076 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5077 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[56 (-1412491060609810432)]} 0 3
[junit4:junit4]   2> 5078 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10072 (1412491060612956160)]} 0 1
[junit4:junit4]   2> 5079 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[75 (1412491060614004736)]} 0 1
[junit4:junit4]   2> 5082 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5083 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10072 (1412491060616101888)]} 0 3
[junit4:junit4]   2> 5086 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10052 (-1412491060622393344)]} 0 1
[junit4:junit4]   2> 5090 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5090 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5090 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[75 (1412491060622393344)]} 0 4
[junit4:junit4]   2> 5093 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[76 (1412491060629733376)]} 0 0
[junit4:junit4]   2> 5094 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[10052 (-1412491060624490496)]} 0 6
[junit4:junit4]   2> 5097 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10073 (1412491060632879104)]} 0 1
[junit4:junit4]   2> 5099 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5100 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[76 (1412491060632879104)]} 0 4
[junit4:junit4]   2> 5103 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[57 (-1412491060640219136)]} 0 1
[junit4:junit4]   2> 5109 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5110 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[57 (-1412491060642316288)]} 0 5
[junit4:junit4]   2> 5120 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5121 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10073 (1412491060636024832)]} 0 22
[junit4:junit4]   2> 5123 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[10054 (-1412491060661190656)]} 0 0
[junit4:junit4]   2> 5128 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5129 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[10054 (-1412491060663287808)]} 0 4
[junit4:junit4]   2> 5133 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10074 (1412491060670627840)]} 0 2
[junit4:junit4]   2> 5144 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[77 (1412491060649656320)]} 0 32
[junit4:junit4]   2> 5154 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=12 
[junit4:junit4]   2> 5155 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10074 (1412491060675870720)]} 0 19
[junit4:junit4]   2> 5157 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10056 (-1412491060696842240)]} 0 0
[junit4:junit4]   2> 5162 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5163 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[10056 (-1412491060699987968)]} 0 3
[junit4:junit4]   2> 5167 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10075 (1412491060706279424)]} 0 1
[junit4:junit4]   2> 5173 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5174 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10075 (1412491060710473728)]} 0 5
[junit4:junit4]   2> 5178 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10076 (1412491060717813760)]} 0 2
[junit4:junit4]   2> 5183 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5184 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10076 (1412491060720959488)]} 0 4
[junit4:junit4]   2> 5187 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10057 (-1412491060728299520)]} 0 1
[junit4:junit4]   2> 5192 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5193 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5195 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[77 (1412491060686356480)]} 0 49
[junit4:junit4]   2> 5195 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[10057 (-1412491060731445248)]} 0 6
[junit4:junit4]   2> 5197 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[59 (-1412491060738785280)]} 0 0
[junit4:junit4]   2> 5199 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10077 (1412491060739833856)]} 0 1
[junit4:junit4]   2> 5203 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5204 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5205 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10077 (1412491060742979584)]} 0 4
[junit4:junit4]   2> 5205 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[59 (-1412491060740882432)]} 0 6
[junit4:junit4]   2> 5209 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[10059 (-1412491060751368192)]} 0 1
[junit4:junit4]   2> 5213 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5214 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[10059 (-1412491060754513920)]} 0 2
[junit4:junit4]   2> 5216 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[78 (1412491060758708224)]} 0 1
[junit4:junit4]   2> 5217 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10078 (1412491060759756800)]} 0 0
[junit4:junit4]   2> 5222 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5223 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10078 (1412491060761853953)]} 0 4
[junit4:junit4]   2> 5225 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=4 
[junit4:junit4]   2> 5226 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10079 (1412491060769193984)]} 0 1
[junit4:junit4]   2> 5227 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[78 (1412491060761853952)]} 0 9
[junit4:junit4]   2> 5232 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[79 (1412491060774436864)]} 0 2
[junit4:junit4]   2> 5236 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=3 
[junit4:junit4]   2> 5237 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10079 (1412491060772339712)]} 0 8
[junit4:junit4]   2> 5237 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5238 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[79 (1412491060778631168)]} 0 3
[junit4:junit4]   2> 5239 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[10060 (-1412491060782825472)]} 0 0
[junit4:junit4]   2> 5240 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[60 (-1412491060783874048)]} 0 0
[junit4:junit4]   2> 5243 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5244 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[10060 (-1412491060785971200)]} 0 3
[junit4:junit4]   2> 5245 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5246 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[60 (-1412491060787019776)]} 0 3
[junit4:junit4]   2> 5248 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10080 (1412491060792262656)]} 0 1
[junit4:junit4]   2> 5254 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5255 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10080 (1412491060795408384)]} 0 4
[junit4:junit4]   2> 5258 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10081 (1412491060801699840)]} 0 1
[junit4:junit4]   2> 5261 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[80 (1412491060794359808)]} 0 11
[junit4:junit4]   2> 5267 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 5268 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[80 (1412491060809039872)]} 0 5
[junit4:junit4]   2> 5270 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[81 (1412491060815331328)]} 0 0
[junit4:junit4]   2> 5276 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5276 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[81 (1412491060818477056)]} 0 3
[junit4:junit4]   2> 5277 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=14 
[junit4:junit4]   2> 5279 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10081 (1412491060805894144)]} 0 18
[junit4:junit4]   2> 5281 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[82 (1412491060824768512)]} 0 2
[junit4:junit4]   2> 5283 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10082 (1412491060827914240)]} 0 1
[junit4:junit4]   2> 5288 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5289 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10082 (1412491060831059968)]} 0 4
[junit4:junit4]   2> 5287 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5291 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[82 (1412491060830011392)]} 0 7
[junit4:junit4]   2> 5292 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10062 (-1412491060838400000)]} 0 0
[junit4:junit4]   2> 5295 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[62 (-1412491060841545728)]} 0 0
[junit4:junit4]   2> 5297 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5297 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[10062 (-1412491060841545728)]} 0 3
[junit4:junit4]   2> 5300 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5300 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10083 (1412491060846788608)]} 0 0
[junit4:junit4]   2> 5301 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[62 (-1412491060844691456)]} 0 4
[junit4:junit4]   2> 5304 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[83 (1412491060850982912)]} 0 1
[junit4:junit4]   2> 5305 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5306 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10083 (1412491060849934336)]} 0 3
[junit4:junit4]   2> 5308 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5309 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10063 (-1412491060856225792)]} 0 0
[junit4:junit4]   2> 5310 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[83 (1412491060853080064)]} 0 4
[junit4:junit4]   2> 5312 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[63 (-1412491060859371520)]} 0 0
[junit4:junit4]   2> 5313 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5314 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[10063 (-1412491060858322944)]} 0 3
[junit4:junit4]   2> 5316 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5316 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10084 (1412491060863565824)]} 0 0
[junit4:junit4]   2> 5318 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[63 (-1412491060862517248)]} 0 3
[junit4:junit4]   2> 5321 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[84 (1412491060867760128)]} 0 1
[junit4:junit4]   2> 5324 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5330 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10084 (1412491060869857280)]} 0 8
[junit4:junit4]   2> 5335 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5336 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10085 (1412491060884537344)]} 0 0
[junit4:junit4]   2> 5336 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[84 (1412491060870905856)]} 0 13
[junit4:junit4]   2> 5348 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5349 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10085 (1412491060887683072)]} 0 10
[junit4:junit4]   2> 5353 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10086 (1412491060901314560)]} 0 2
[junit4:junit4]   2> 5356 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[85 (1412491060888731648)]} 0 17
[junit4:junit4]   2> 5371 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5376 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10086 (1412491060904460288)]} 0 21
[junit4:junit4]   2> 5377 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=9 
[junit4:junit4]   2> 5378 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[85 (1412491060914946048)]} 0 13
[junit4:junit4]   2> 5386 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10087 (1412491060929626112)]} 0 7
[junit4:junit4]   2> 5386 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[86 (1412491060930674688)]} 0 6
[junit4:junit4]   2> 5391 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5391 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5392 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10087 (1412491060939063296)]} 0 4
[junit4:junit4]   2> 5393 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[86 (1412491060940111872)]} 0 5
[junit4:junit4]   2> 5394 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10064 (-1412491060945354752)]} 0 0
[junit4:junit4]   2> 5397 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[87 (1412491060948500480)]} 0 0
[junit4:junit4]   2> 5398 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5399 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10064 (-1412491060948500480)]} 0 2
[junit4:junit4]   2> 5402 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5403 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[87 (1412491060950597632)]} 0 4
[junit4:junit4]   2> 5404 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10088 (1412491060954791936)]} 0 1
[junit4:junit4]   2> 5405 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[64 (-1412491060956889088)]} 0 0
[junit4:junit4]   2> 5409 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5409 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5410 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10088 (1412491060957937664)]} 0 4
[junit4:junit4]   2> 5410 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[64 (-1412491060960034816)]} 0 2
[junit4:junit4]   2> 5412 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10065 (-1412491060964229120)]} 0 0
[junit4:junit4]   2> 5412 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[88 (1412491060964229121)]} 0 0
[junit4:junit4]   2> 5416 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5417 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5417 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10065 (-1412491060966326272)]} 0 3
[junit4:junit4]   2> 5419 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[88 (1412491060966326273)]} 0 5
[junit4:junit4]   2> 5421 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10089 (1412491060972617728)]} 0 1
[junit4:junit4]   2> 5422 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[65 (-1412491060974714880)]} 0 0
[junit4:junit4]   2> 5426 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5426 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5427 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[65 (-1412491060976812032)]} 0 3
[junit4:junit4]   2> 5428 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10089 (1412491060975763456)]} 0 5
[junit4:junit4]   2> 5430 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[10067 (-1412491060983103488)]} 0 0
[junit4:junit4]   2> 5430 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[89 (1412491060982054912)]} 0 1
[junit4:junit4]   2> 5436 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5437 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[89 (1412491060987297792)]} 0 4
[junit4:junit4]   2> 5439 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5440 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[67 (-1412491060993589248)]} 0 0
[junit4:junit4]   2> 5441 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[10067 (-1412491060986249216)]} 0 8
[junit4:junit4]   2> 5444 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10090 (1412491060996734976)]} 0 1
[junit4:junit4]   2> 5445 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5446 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[67 (-1412491060995686400)]} 0 4
[junit4:junit4]   2> 5457 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5462 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[90 (1412491061003026432)]} 0 13
[junit4:junit4]   2> 5463 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10090 (1412491061001977856)]} 0 15
[junit4:junit4]   2> 5470 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10068 (-1412491061022949376)]} 0 4
[junit4:junit4]   2> 5474 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5475 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10068 (-1412491061027143680)]} 0 3
[junit4:junit4]   2> 5486 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10091 (1412491061039726592)]} 0 2
[junit4:junit4]   2> 5489 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=22 
[junit4:junit4]   2> 5490 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[90 (1412491061019803648)]} 0 25
[junit4:junit4]   2> 5492 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[68 (-1412491061048115200)]} 0 0
[junit4:junit4]   2> 5525 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5528 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[68 (-1412491061051260928)]} 0 33
[junit4:junit4]   2> 5533 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[91 (1412491061089009664)]} 0 3
[junit4:junit4]   2> 5535 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=41 
[junit4:junit4]   2> 5536 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10091 (1412491061046018048)]} 0 46
[junit4:junit4]   2> 5539 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10092 (1412491061096349696)]} 0 1
[junit4:junit4]   2> 5541 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5543 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[91 (1412491061094252544)]} 0 7
[junit4:junit4]   2> 5544 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5545 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10092 (1412491061099495424)]} 0 4
[junit4:junit4]   2> 5546 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[92 (1412491061104738304)]} 0 1
[junit4:junit4]   2> 5547 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[10070 (-1412491061105786880)]} 0 0
[junit4:junit4]   2> 5551 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5552 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[92 (1412491061107884032)]} 0 3
[junit4:junit4]   2> 5554 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 5554 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[70 (-1412491061113126912)]} 0 0
[junit4:junit4]   2> 5556 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[10070 (-1412491061108932608)]} 0 6
[junit4:junit4]   2> 5559 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10093 (1412491061117321216)]} 0 1
[junit4:junit4]   2> 5561 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5572 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[70 (-1412491061116272640)]} 0 15
[junit4:junit4]   2> 5573 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5574 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10093 (1412491061120466944)]} 0 13
[junit4:junit4]   2> 5575 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[93 (1412491061135147008)]} 0 0
[junit4:junit4]   2> 5577 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10094 (1412491061137244160)]} 0 0
[junit4:junit4]   2> 5582 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5583 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10094 (1412491061140389888)]} 0 4
[junit4:junit4]   2> 5586 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5587 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[10072 (-1412491061145632768)]} 0 2
[junit4:junit4]   2> 5588 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[93 (1412491061138292736)]} 0 10
[junit4:junit4]   2> 5591 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5592 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10072 (-1412491061149827072)]} 0 3
[junit4:junit4]   2> 5593 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[94 (1412491061150875648)]} 0 3
[junit4:junit4]   2> 5595 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10095 (1412491061155069952)]} 0 1
[junit4:junit4]   2> 5598 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5599 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[94 (1412491061157167104)]} 0 3
[junit4:junit4]   2> 5602 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[72 (-1412491061163458560)]} 0 1
[junit4:junit4]   2> 5605 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5606 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10095 (1412491061158215680)]} 0 9
[junit4:junit4]   2> 5607 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5608 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[72 (-1412491061165555712)]} 0 4
[junit4:junit4]   2> 5609 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[10073 (-1412491061170798592)]} 0 0
[junit4:junit4]   2> 5613 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5614 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10073 (-1412491061172895744)]} 0 3
[junit4:junit4]   2> 5618 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10096 (1412491061178138624)]} 0 2
[junit4:junit4]   2> 5624 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[95 (1412491061171847168)]} 0 14
[junit4:junit4]   2> 5633 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 5634 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[95 (1412491061189672960)]} 0 8
[junit4:junit4]   2> 5637 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[73 (-1412491061199110144)]} 0 1
[junit4:junit4]   2> 5642 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5643 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[73 (-1412491061202255872)]} 0 4
[junit4:junit4]   2> 5647 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[96 (1412491061209595904)]} 0 1
[junit4:junit4]   2> 5652 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5653 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[96 (1412491061212741632)]} 0 4
[junit4:junit4]   2> 5656 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[97 (1412491061220081664)]} 0 0
[junit4:junit4]   2> 5667 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5667 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[97 (1412491061225324544)]} 0 8
[junit4:junit4]   2> 5670 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[98 (1412491061234761728)]} 0 0
[junit4:junit4]   2> 5680 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 5681 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[98 (1412491061240004608)]} 0 6
[junit4:junit4]   2> 5687 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[75 (-1412491061251538944)]} 0 4
[junit4:junit4]   2> 5689 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=66 
[junit4:junit4]   2> 5690 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10096 (1412491061183381504)]} 0 69
[junit4:junit4]   2> 5694 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10097 (1412491061258878976)]} 0 1
[junit4:junit4]   2> 5695 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5697 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[75 (-1412491061257830400)]} 0 5
[junit4:junit4]   2> 5699 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5700 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[99 (1412491061265170432)]} 0 1
[junit4:junit4]   2> 5700 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10097 (1412491061262024704)]} 0 4
[junit4:junit4]   2> 5703 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10098 (1412491061269364736)]} 0 0
[junit4:junit4]   2> 5711 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5714 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10098 (1412491061275656192)]} 0 5
[junit4:junit4]   2> 5716 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5717 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[10075 (-1412491061284044800)]} 0 1
[junit4:junit4]   2> 5718 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[99 (1412491061271461888)]} 0 14
[junit4:junit4]   2> 5720 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[100 (1412491061287190528)]} 0 0
[junit4:junit4]   2> 5721 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5722 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[10075 (-1412491061286141952)]} 0 3
[junit4:junit4]   2> 5725 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10099 (1412491061292433408)]} 0 0
[junit4:junit4]   2> 5728 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5730 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[100 (1412491061291384832)]} 0 7
[junit4:junit4]   2> 5731 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5732 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10099 (1412491061295579136)]} 0 5
[junit4:junit4]   2> 5742 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[101 (1412491061309210624)]} 0 1
[junit4:junit4]   2> 5743 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10100 (1412491061301870592)]} 0 9
[junit4:junit4]   2> 5750 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5751 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10100 (1412491061314453504)]} 0 5
[junit4:junit4]   2> 5754 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10101 (1412491061322842112)]} 0 1
[junit4:junit4]   2> 5754 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=8 
[junit4:junit4]   2> 5755 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[101 (1412491061312356352)]} 0 11
[junit4:junit4]   2> 5760 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[102 (1412491061329133568)]} 0 1
[junit4:junit4]   2> 5766 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5767 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[102 (1412491061332279296)]} 0 3
[junit4:junit4]   2> 5768 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5769 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[76 (-1412491061338570752)]} 0 0
[junit4:junit4]   2> 5769 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10101 (1412491061325987840)]} 0 13
[junit4:junit4]   2> 5772 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10102 (1412491061341716480)]} 0 1
[junit4:junit4]   2> 5773 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5774 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[76 (-1412491061340667904)]} 0 3
[junit4:junit4]   2> 5777 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[103 (1412491061346959360)]} 0 1
[junit4:junit4]   2> 5778 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5779 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10102 (1412491061343813632)]} 0 5
[junit4:junit4]   2> 5781 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[10076 (-1412491061351153664)]} 0 0
[junit4:junit4]   2> 5783 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5783 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[103 (1412491061350105088)]} 0 4
[junit4:junit4]   2> 5785 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5786 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[78 (-1412491061356396544)]} 0 0
[junit4:junit4]   2> 5787 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10076 (-1412491061353250816)]} 0 4
[junit4:junit4]   2> 5790 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10103 (1412491061360590848)]} 0 0
[junit4:junit4]   2> 5791 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5792 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[78 (-1412491061358493696)]} 0 4
[junit4:junit4]   2> 5795 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[104 (1412491061364785152)]} 0 1
[junit4:junit4]   2> 5796 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5796 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10103 (1412491061363736576)]} 0 3
[junit4:junit4]   2> 5799 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[10078 (-1412491061370028032)]} 0 0
[junit4:junit4]   2> 5800 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5801 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[104 (1412491061367930880)]} 0 4
[junit4:junit4]   2> 5803 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5804 T1316 C117 P47138 /update {version=2&wt=javabin} {delete=[10078 (-1412491061372125184)]} 0 3
[junit4:junit4]   2> 5806 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[105 (1412491061376319488)]} 0 1
[junit4:junit4]   2> 5807 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[10104 (1412491061378416640)]} 0 0
[junit4:junit4]   2> 5810 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5811 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[105 (1412491061379465216)]} 0 3
[junit4:junit4]   2> 5811 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5812 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[10104 (1412491061380513792)]} 0 3
[junit4:junit4]   2> 5813 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[81 (-1412491061384708096)]} 0 0
[junit4:junit4]   2> 5817 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 5818 T1317 C117 P47138 /update {version=2&wt=javabin} {delete=[81 (-1412491061386805248)]} 0 3
[junit4:junit4]   2> 5821 T1302 C116 P45579 /update {version=2&wt=javabin} {add=[106 (1412491061392048128)]} 0 1
[junit4:junit4]   2> 5823 T1301 C116 P45579 /update {version=2&wt=javabin} {add=[10105 (1412491061385756672)]} 0 9
[junit4:junit4]   2> 5829 T1327 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5830 T1316 C117 P47138 /update {version=2&wt=javabin} {add=[10105 (1412491061397291008)]} 0 5
[junit4:junit4]   2> 5832 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=7 
[junit4:junit4]   2> 5833 T1317 C117 P47138 /update {version=2&wt=javabin} {add=[106 (1412491061395193856)]} 0 10
[junit4:junit4]   2> 5834 T1301 C116 P45579 /update {version=2&wt=javabin} {delete=[10081 (-1412491061406728192)]} 0 1
[junit4:junit4]   2> 5835 T1302 C116 P45579 /update {version=2&wt=javabin} {delete=[83 (-1412491061407776768)]} 0 0
[junit4:junit4]   2> 5838 T1328 C115 P44424 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47138/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 5838 T

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

Impl exited loop!
[junit4:junit4]   2> 24431 T1289 oasc.ChaosMonkey.monkeyLog monkey: stop shard! 44424
[junit4:junit4]   2> 24432 T1289 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=444570349
[junit4:junit4]   2> 25680 T1448 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost.localdomain/127.0.0.1:40845
[junit4:junit4]   2> 25781 T1449 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 25781 T1289 oaz.ZooKeeper.close Session: 0x139a2d218f70007 closed
[junit4:junit4]   2> 25782 T1289 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 25935 T1289 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=RecoveryZkTest -Dtests.method=testDistribSearch -Dtests.seed=BC48C95B6D95671F -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=tr -Dtests.timezone=Antarctica/Casey -Dtests.file.encoding=ISO-8859-1
[junit4:junit4] ERROR   26.0s J1 | RecoveryZkTest.testDistribSearch <<<
[junit4:junit4]    > Throwable #1: org.apache.solr.common.SolrException: Server at http://localhost:44424/solr/collection1 returned non ok status:404, message:Can not find: /solr/collection1/select
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([BC48C95B6D95671F:3DAE47431ACA0723]:0)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:373)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:182)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:90)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:324)
[junit4:junit4]    > 	at org.apache.solr.cloud.RecoveryZkTest.doTest(RecoveryZkTest.java:92)
[junit4:junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:691)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:88)
[junit4:junit4]    > 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
[junit4:junit4]    > 	at java.lang.reflect.Method.invoke(Method.java:613)
[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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:40)
[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:777)
[junit4:junit4]   2> 25963 T1289 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4]   2> NOTE: test params are: codec=Lucene40: {range_facet_si=PostingsFormat(name=Lucene40WithOrds), range_facet_l=PostingsFormat(name=Lucene40WithOrds), range_facet_sl=Pulsing40(freqCutoff=20 minBlockSize=75 maxBlockSize=149), _version_=PostingsFormat(name=MockRandom), multiDefault=PostingsFormat(name=Lucene40WithOrds), other_tl1=PostingsFormat(name=MockRandom), rnd_b=Pulsing40(freqCutoff=20 minBlockSize=75 maxBlockSize=149), text=MockFixedIntBlock(blockSize=596), intDefault=PostingsFormat(name=MockRandom), a_si=PostingsFormat(name=MockRandom), a_t=PostingsFormat(name=Lucene40WithOrds), timestamp=PostingsFormat(name=Lucene40WithOrds), id=Pulsing40(freqCutoff=20 minBlockSize=75 maxBlockSize=149)}, sim=DefaultSimilarity, locale=tr, timezone=Antarctica/Casey
[junit4:junit4]   2> NOTE: Linux 3.2.0-29-generic x86/IBM Corporation 1.7.0 (32-bit)/cpus=8,threads=1,free=102904904,total=156893184
[junit4:junit4]   2> NOTE: All tests run in this JVM: [TestSolrDeletionPolicy1, BasicFunctionalityTest, TestArbitraryIndexDir, TestSolrDeletionPolicy2, IndexSchemaRuntimeFieldTest, PrimitiveFieldTypeTest, QueryEqualityTest, ZkCLITest, TestUtils, TestMergePolicyConfig, TestValueSourceCache, PingRequestHandlerTest, TestSurroundQueryParser, TestDistributedGrouping, FileUtilsTest, TestRecovery, TestSolrCoreProperties, SuggesterTest, RequiredFieldsTest, TestJmxIntegration, ReturnFieldsTest, TestLRUCache, SolrCoreTest, TestDistributedSearch, TestStressRecovery, DebugComponentTest, DistributedQueryElevationComponentTest, TestReload, SolrIndexConfigTest, TestFoldingMultitermQuery, BadIndexSchemaTest, TestPropInjectDefaults, UUIDFieldTest, EchoParamsTest, XsltUpdateRequestHandlerTest, TestBinaryField, SimplePostToolTest, OpenExchangeRatesOrgProviderTest, TestPhraseSuggestions, MultiTermTest, TestMultiCoreConfBootstrap, ZkSolrClientTest, PolyFieldTest, IndexSchemaTest, TestCSVLoader, HighlighterTest, TestRTGBase, UpdateParamsTest, TermVectorComponentTest, TestRealTimeGet, ConvertedLegacyTest, SoftAutoCommitTest, ZkNodePropsTest, TestBM25SimilarityFactory, FieldMutatingUpdateProcessorTest, TestQuerySenderListener, TimeZoneUtilsTest, OverseerTest, RecoveryZkTest]
[junit4:junit4] Completed on J1 in 25.98s, 1 test, 1 error <<< FAILURES!

[...truncated 363 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:29: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:146: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/module-build.xml:63: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1133: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:810: There were test failures: 228 suites, 920 tests, 1 error, 6 ignored (1 assumption)

Total time: 25 minutes 15 seconds
Build step 'Invoke Ant' marked build as failure
Recording test results
Description set: Java: 32bit/ibm-j9-jdk7 -Xjit:exclude={org/apache/lucene/util/fst/FST.pack(IIF)Lorg/apache/lucene/util/fst/FST;}
Email was triggered for: Failure
Sending email for trigger: Failure



Mime
View raw message