lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@thetaphi.de>
Subject [JENKINS] Lucene-Solr-trunk-Windows (32bit/jdk1.7.0_10) - Build # 2509 - Failure!
Date Tue, 05 Feb 2013 06:03:21 GMT
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/2509/
Java: 32bit/jdk1.7.0_10 -client -XX:+UseConcMarkSweepGC

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

Error Message:
expected:<376> but was:<2>

Stack Trace:
java.lang.AssertionError: expected:<376> but was:<2>
	at __randomizedtesting.SeedInfo.seed([9539959EDD47197B:14DF1B86AA187947]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.failNotEquals(Assert.java:647)
	at org.junit.Assert.assertEquals(Assert.java:128)
	at org.junit.Assert.assertEquals(Assert.java:472)
	at org.junit.Assert.assertEquals(Assert.java:456)
	at org.apache.solr.cloud.RecoveryZkTest.doTest(RecoveryZkTest.java:106)
	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:794)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:601)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
	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:46)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
	at java.lang.Thread.run(Thread.java:722)




Build Log:
[...truncated 8822 lines...]
[junit4:junit4] Suite: org.apache.solr.cloud.RecoveryZkTest
[junit4:junit4]   2> 0 T1118 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /_vua/
[junit4:junit4]   2> 5 T1118 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4:junit4]   2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-RecoveryZkTest-1360042958917
[junit4:junit4]   2> 8 T1118 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4]   2> 9 T1119 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server
[junit4:junit4]   2> 13 T1119 oazs.ZooKeeperServer.setTickTime tickTime set to 1000
[junit4:junit4]   2> 13 T1119 oazs.ZooKeeperServer.setMinSessionTimeout minSessionTimeout set to -1
[junit4:junit4]   2> 14 T1119 oazs.ZooKeeperServer.setMaxSessionTimeout maxSessionTimeout set to -1
[junit4:junit4]   2> 15 T1119 oazs.NIOServerCnxnFactory.configure binding to port 0.0.0.0/0.0.0.0:0
[junit4:junit4]   2> 16 T1119 oazsp.FileTxnSnapLog.save Snapshotting: 0x0 to C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\zookeeper\server1\data\version-2\snapshot.0
[junit4:junit4]   2> 120 T1118 oasc.ZkTestServer.run start zk server on port:53320
[junit4:junit4]   2> 121 T1118 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:53320 sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@3b53bf
[junit4:junit4]   2> 123 T1118 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 124 T1124 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server 127.0.0.1/127.0.0.1:53320. Will not attempt to authenticate using SASL (access denied ("javax.security.auth.AuthPermission" "getLoginConfiguration"))
[junit4:junit4]   2> 125 T1124 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to 127.0.0.1/127.0.0.1:53320, initiating session
[junit4:junit4]   2> 125 T1120 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:53323
[junit4:junit4]   2> 125 T1120 oazs.ZooKeeperServer.processConnectRequest Client attempting to establish new session at /127.0.0.1:53323
[junit4:junit4]   2> 126 T1122 oazsp.FileTxnLog.append Creating new log file: log.1
[junit4:junit4]   2> 135 T1122 oazs.ZooKeeperServer.finishSessionInit Established session 0x13ca8e0a0520000 with negotiated timeout 10000 for client /127.0.0.1:53323
[junit4:junit4]   2> 135 T1124 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server 127.0.0.1/127.0.0.1:53320, sessionid = 0x13ca8e0a0520000, negotiated timeout = 10000
[junit4:junit4]   2> 135 T1125 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@3b53bf name:ZooKeeperConnection Watcher:127.0.0.1:53320 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 136 T1118 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 136 T1118 oascc.SolrZkClient.makePath makePath: /solr
[junit4:junit4]   2> 143 T1123 oazs.PrepRequestProcessor.pRequest2Txn Processed session termination for sessionid: 0x13ca8e0a0520000
[junit4:junit4]   2> 147 T1125 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 147 T1118 oaz.ZooKeeper.close Session: 0x13ca8e0a0520000 closed
[junit4:junit4]   2> 147 T1120 oazs.NIOServerCnxn.doIO WARNING caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x13ca8e0a0520000, likely client has closed socket
[junit4:junit4]   2> 	at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:220)
[junit4:junit4]   2> 	at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4:junit4]   2> 	at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 
[junit4:junit4]   2> 149 T1118 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:53320/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@2dfaf3
[junit4:junit4]   2> 151 T1120 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:53323 which had sessionid 0x13ca8e0a0520000
[junit4:junit4]   2> 153 T1118 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 154 T1126 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server 127.0.0.1/127.0.0.1:53320. Will not attempt to authenticate using SASL (access denied ("javax.security.auth.AuthPermission" "getLoginConfiguration"))
[junit4:junit4]   2> 154 T1126 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to 127.0.0.1/127.0.0.1:53320, initiating session
[junit4:junit4]   2> 155 T1120 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:53326
[junit4:junit4]   2> 155 T1120 oazs.ZooKeeperServer.processConnectRequest Client attempting to establish new session at /127.0.0.1:53326
[junit4:junit4]   2> 157 T1122 oazs.ZooKeeperServer.finishSessionInit Established session 0x13ca8e0a0520001 with negotiated timeout 10000 for client /127.0.0.1:53326
[junit4:junit4]   2> 157 T1126 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server 127.0.0.1/127.0.0.1:53320, sessionid = 0x13ca8e0a0520001, negotiated timeout = 10000
[junit4:junit4]   2> 158 T1127 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@2dfaf3 name:ZooKeeperConnection Watcher:127.0.0.1:53320/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 158 T1118 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 158 T1118 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4:junit4]   2> 166 T1118 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4:junit4]   2> 183 T1118 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4:junit4]   2> 192 T1118 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4:junit4]   2> 207 T1118 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\conf\solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 208 T1118 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 228 T1118 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\conf\schema.xml to /configs/conf1/schema.xml
[junit4:junit4]   2> 229 T1118 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4:junit4]   2> 237 T1118 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\conf\stopwords.txt to /configs/conf1/stopwords.txt
[junit4:junit4]   2> 238 T1118 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
[junit4:junit4]   2> 244 T1118 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\conf\protwords.txt to /configs/conf1/protwords.txt
[junit4:junit4]   2> 245 T1118 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
[junit4:junit4]   2> 253 T1118 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\conf\currency.xml to /configs/conf1/currency.xml
[junit4:junit4]   2> 254 T1118 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
[junit4:junit4]   2> 260 T1118 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\conf\open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 261 T1118 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 277 T1118 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 279 T1118 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 284 T1118 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\conf\old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 285 T1118 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 294 T1118 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\conf\synonyms.txt to /configs/conf1/synonyms.txt
[junit4:junit4]   2> 294 T1118 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
[junit4:junit4]   2> 299 T1123 oazs.PrepRequestProcessor.pRequest2Txn Processed session termination for sessionid: 0x13ca8e0a0520001
[junit4:junit4]   2> 300 T1127 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 300 T1118 oaz.ZooKeeper.close Session: 0x13ca8e0a0520001 closed
[junit4:junit4]   2> 301 T1120 oazs.NIOServerCnxn.doIO WARNING caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x13ca8e0a0520001, likely client has closed socket
[junit4:junit4]   2> 	at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:220)
[junit4:junit4]   2> 	at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4:junit4]   2> 	at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 
[junit4:junit4]   2> 302 T1120 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:53326 which had sessionid 0x13ca8e0a0520001
[junit4:junit4]   2> 747 T1118 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 758 T1118 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:53327
[junit4:junit4]   2> 758 T1118 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 759 T1118 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 759 T1118 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-controljetty-1360042959213
[junit4:junit4]   2> 759 T1118 oasc.CoreContainer$Initializer.initialize looking for solr.xml: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-controljetty-1360042959213\solr.xml
[junit4:junit4]   2> 760 T1118 oasc.CoreContainer.<init> New CoreContainer 32337293
[junit4:junit4]   2> 760 T1118 oasc.CoreContainer.load Loading CoreContainer using Solr Home: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-controljetty-1360042959213\'
[junit4:junit4]   2> 760 T1118 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-controljetty-1360042959213\'
[junit4:junit4]   2> 811 T1118 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 60000
[junit4:junit4]   2> 811 T1118 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 811 T1118 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4:junit4]   2> 811 T1118 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 811 T1118 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 812 T1118 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 812 T1118 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 814 T1118 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 814 T1118 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 814 T1118 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=60000&connTimeout=15000&retry=false
[junit4:junit4]   2> 831 T1118 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 867 T1118 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:53320/solr
[junit4:junit4]   2> 868 T1118 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4:junit4]   2> 869 T1118 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:53320 sessionTimeout=60000 watcher=org.apache.solr.common.cloud.ConnectionManager@1f8a2c6
[junit4:junit4]   2> 870 T1118 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 872 T1137 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server 127.0.0.1/127.0.0.1:53320. Will not attempt to authenticate using SASL (access denied ("javax.security.auth.AuthPermission" "getLoginConfiguration"))
[junit4:junit4]   2> 874 T1137 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to 127.0.0.1/127.0.0.1:53320, initiating session
[junit4:junit4]   2> 874 T1120 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:53332
[junit4:junit4]   2> 874 T1120 oazs.ZooKeeperServer.processConnectRequest Client attempting to establish new session at /127.0.0.1:53332
[junit4:junit4]   2> 888 T1122 oazs.ZooKeeperServer.finishSessionInit Established session 0x13ca8e0a0520002 with negotiated timeout 20000 for client /127.0.0.1:53332
[junit4:junit4]   2> 888 T1137 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server 127.0.0.1/127.0.0.1:53320, sessionid = 0x13ca8e0a0520002, negotiated timeout = 20000
[junit4:junit4]   2> 888 T1138 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1f8a2c6 name:ZooKeeperConnection Watcher:127.0.0.1:53320 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 889 T1118 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 891 T1123 oazs.PrepRequestProcessor.pRequest2Txn Processed session termination for sessionid: 0x13ca8e0a0520002
[junit4:junit4]   2> 913 T1138 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 913 T1118 oaz.ZooKeeper.close Session: 0x13ca8e0a0520002 closed
[junit4:junit4]   2> 913 T1120 oazs.NIOServerCnxn.doIO WARNING caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x13ca8e0a0520002, likely client has closed socket
[junit4:junit4]   2> 	at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:220)
[junit4:junit4]   2> 	at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4:junit4]   2> 	at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 
[junit4:junit4]   2> 914 T1118 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=500&maxConnectionsPerHost=16&socketTimeout=60000&connTimeout=15000
[junit4:junit4]   2> 916 T1120 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:53332 which had sessionid 0x13ca8e0a0520002
[junit4:junit4]   2> 921 T1118 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:53320/solr sessionTimeout=30000 watcher=org.apache.solr.common.cloud.ConnectionManager@1e42a9f
[junit4:junit4]   2> 923 T1118 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 924 T1139 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server 127.0.0.1/127.0.0.1:53320. Will not attempt to authenticate using SASL (access denied ("javax.security.auth.AuthPermission" "getLoginConfiguration"))
[junit4:junit4]   2> 925 T1139 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to 127.0.0.1/127.0.0.1:53320, initiating session
[junit4:junit4]   2> 925 T1120 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:53335
[junit4:junit4]   2> 926 T1120 oazs.ZooKeeperServer.processConnectRequest Client attempting to establish new session at /127.0.0.1:53335
[junit4:junit4]   2> 936 T1122 oazs.ZooKeeperServer.finishSessionInit Established session 0x13ca8e0a0520003 with negotiated timeout 20000 for client /127.0.0.1:53335
[junit4:junit4]   2> 936 T1139 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server 127.0.0.1/127.0.0.1:53320, sessionid = 0x13ca8e0a0520003, negotiated timeout = 20000
[junit4:junit4]   2> 937 T1140 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1e42a9f name:ZooKeeperConnection Watcher:127.0.0.1:53320/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 937 T1118 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 941 T1123 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ca8e0a0520003 type:create cxid:0x2 zxid:0x1a txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 951 T1118 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4:junit4]   2> 956 T1118 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:53327__vua
[junit4:junit4]   2> 957 T1123 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ca8e0a0520003 type:delete cxid:0x7 zxid:0x1c txntype:-1 reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:53327__vua Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:53327__vua
[junit4:junit4]   2> 959 T1118 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:53327__vua
[junit4:junit4]   2> 967 T1118 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4:junit4]   2> 994 T1123 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ca8e0a0520003 type:delete cxid:0x15 zxid:0x21 txntype:-1 reqpath:n/a Error Path:/solr/overseer_elect/leader Error:KeeperErrorCode = NoNode for /solr/overseer_elect/leader
[junit4:junit4]   2> 996 T1118 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4]   2> 1005 T1118 oasc.Overseer.start Overseer (id=89131775356436483-127.0.0.1:53327__vua-n_0000000000) starting
[junit4:junit4]   2> 1007 T1123 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ca8e0a0520003 type:create cxid:0x1a zxid:0x23 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1013 T1123 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ca8e0a0520003 type:create cxid:0x1b zxid:0x24 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1027 T1123 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ca8e0a0520003 type:create cxid:0x1c zxid:0x25 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1036 T1123 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ca8e0a0520003 type:create cxid:0x1d zxid:0x26 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1041 T1142 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
[junit4:junit4]   2> 1043 T1118 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4:junit4]   2> 1068 T1118 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 1081 T1141 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4]   2> 1097 T1143 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-controljetty-1360042959213\collection1
[junit4:junit4]   2> 1097 T1143 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection
[junit4:junit4]   2> 1099 T1143 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 1100 T1143 oasc.ZkController.readConfigName Load collection config from:/collections/control_collection
[junit4:junit4]   2> 1107 T1143 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-controljetty-1360042959213\collection1\'
[junit4:junit4]   2> 1111 T1143 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-controljetty-1360042959213/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 1114 T1143 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-controljetty-1360042959213/collection1/lib/README' to classloader
[junit4:junit4]   2> 1215 T1143 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 1332 T1143 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 1334 T1143 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 1346 T1143 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 2313 T1143 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 2330 T1143 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 2338 T1143 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 2358 T1143 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 2365 T1143 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 2370 T1143 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 2371 T1143 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 2373 T1143 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-controljetty-1360042959213\collection1\, dataDir=.\org.apache.solr.cloud.RecoveryZkTest-1360042958916/control/data\
[junit4:junit4]   2> 2373 T1143 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@f4daba
[junit4:junit4]   2> 2374 T1143 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 2374 T1143 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\control\data forceNew:false
[junit4:junit4]   2> 2375 T1143 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\control\data
[junit4:junit4]   2> 2375 T1143 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=.\org.apache.solr.cloud.RecoveryZkTest-1360042958916/control/data\index/
[junit4:junit4]   2> 2376 T1143 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\control\data\index' doesn't exist. Creating new index...
[junit4:junit4]   2> 2378 T1143 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\control\data\index forceNew:false
[junit4:junit4]   2> 2382 T1143 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@85b2ea lockFactory=org.apache.lucene.store.NativeFSLockFactory@b4b4a0)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 2383 T1143 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 2384 T1143 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\control\data\index
[junit4:junit4]   2> 2385 T1143 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 2386 T1143 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 2387 T1143 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 2387 T1143 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 2388 T1143 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 2388 T1143 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 2388 T1143 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 2389 T1143 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 2389 T1143 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 2389 T1143 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 2390 T1143 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 2390 T1143 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 2390 T1143 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 2392 T1143 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 2392 T1143 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 2393 T1143 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 2393 T1143 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 2401 T1143 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2401 T1143 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2402 T1143 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2402 T1143 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2402 T1143 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2403 T1143 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2403 T1143 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2403 T1143 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2404 T1143 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 2405 T1143 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 2417 T1143 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 2424 T1143 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 2425 T1143 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SCHEMA.XML, OLD_SYNONYMS.TXT, STOPWORDS.TXT, PROTWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, SYNONYMS.TXT, CURRENCY.XML, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 2428 T1143 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\control\data
[junit4:junit4]   2> 2429 T1143 oass.SolrIndexSearcher.<init> Opening Searcher@1ce470c main
[junit4:junit4]   2> 2432 T1143 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 2433 T1143 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 2433 T1143 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 2454 T1143 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 2564 T1144 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1ce470c main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 2573 T1143 oasc.ZkController.publish publishing core=collection1 state=down
[junit4:junit4]   2> 2573 T1143 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 2574 T1123 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ca8e0a0520003 type:create cxid:0x50 zxid:0x29 txntype:-1 reqpath:n/a Error Path:/solr/overseer/queue Error:KeeperErrorCode = NoNode for /solr/overseer/queue
[junit4:junit4]   2> 2745 T1141 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2746 T1141 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "numShards":"1",
[junit4:junit4]   2> 	  "shard":null,
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "state":"down",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "collection":"control_collection",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:53327__vua",
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:53327/_vua"}
[junit4:junit4]   2> 2747 T1141 oasc.Overseer$ClusterStateUpdater.createCollection Create collection control_collection with numShards 1
[junit4:junit4]   2> 2747 T1141 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1
[junit4:junit4]   2> 2749 T1123 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ca8e0a0520003 type:create cxid:0x58 zxid:0x2c txntype:-1 reqpath:n/a Error Path:/solr/overseer/queue-work Error:KeeperErrorCode = NoNode for /solr/overseer/queue-work
[junit4:junit4]   2> 2794 T1140 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4:junit4]   2> 3700 T1143 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 3700 T1143 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:53327/_vua collection:control_collection shard:shard1
[junit4:junit4]   2> 3702 T1143 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/shard1/election
[junit4:junit4]   2> 3751 T1123 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ca8e0a0520003 type:delete cxid:0x72 zxid:0x36 txntype:-1 reqpath:n/a Error Path:/solr/collections/control_collection/leaders Error:KeeperErrorCode = NoNode for /solr/collections/control_collection/leaders
[junit4:junit4]   2> 3754 T1143 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 3758 T1123 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ca8e0a0520003 type:create cxid:0x73 zxid:0x37 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3772 T1143 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4]   2> 3772 T1143 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 3773 T1143 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:53327/_vua/collection1/
[junit4:junit4]   2> 3774 T1143 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4:junit4]   2> 3775 T1143 oasc.SyncStrategy.syncToMe http://127.0.0.1:53327/_vua/collection1/ has no replicas
[junit4:junit4]   2> 3775 T1143 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:53327/_vua/collection1/
[junit4:junit4]   2> 3775 T1143 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/shard1
[junit4:junit4]   2> 3794 T1123 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ca8e0a0520003 type:create cxid:0x7d zxid:0x3b txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4460 T1141 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 4596 T1140 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4:junit4]   2> 4670 T1143 oasc.ZkController.register We are http://127.0.0.1:53327/_vua/collection1/ and leader is http://127.0.0.1:53327/_vua/collection1/
[junit4:junit4]   2> 4670 T1143 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:53327/_vua
[junit4:junit4]   2> 4671 T1143 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4]   2> 4671 T1143 oasc.ZkController.publish publishing core=collection1 state=active
[junit4:junit4]   2> 4672 T1143 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 4702 T1143 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 4704 T1118 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4:junit4]   2> 4704 T1118 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 4706 T1118 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 4727 T1118 oascsi.HttpClientUtil.createClient Creating new http client, config:
[junit4:junit4]   2> 4734 T1118 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:53320/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@14dc6eb
[junit4:junit4]   2> 4736 T1118 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 4738 T1145 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server 127.0.0.1/127.0.0.1:53320. Will not attempt to authenticate using SASL (access denied ("javax.security.auth.AuthPermission" "getLoginConfiguration"))
[junit4:junit4]   2> 4738 T1145 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to 127.0.0.1/127.0.0.1:53320, initiating session
[junit4:junit4]   2> 4739 T1120 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:53338
[junit4:junit4]   2> 4739 T1120 oazs.ZooKeeperServer.processConnectRequest Client attempting to establish new session at /127.0.0.1:53338
[junit4:junit4]   2> 4750 T1122 oazs.ZooKeeperServer.finishSessionInit Established session 0x13ca8e0a0520004 with negotiated timeout 10000 for client /127.0.0.1:53338
[junit4:junit4]   2> 4750 T1145 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server 127.0.0.1/127.0.0.1:53320, sessionid = 0x13ca8e0a0520004, negotiated timeout = 10000
[junit4:junit4]   2> 4752 T1146 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@14dc6eb name:ZooKeeperConnection Watcher:127.0.0.1:53320/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 4752 T1118 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 4754 T1118 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 4758 T1118 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:true cause connection loss:true
[junit4:junit4]   2> 5188 T1118 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 5191 T1118 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:53339
[junit4:junit4]   2> 5192 T1118 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 5192 T1118 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 5193 T1118 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-jetty1-1360042963669
[junit4:junit4]   2> 5193 T1118 oasc.CoreContainer$Initializer.initialize looking for solr.xml: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-jetty1-1360042963669\solr.xml
[junit4:junit4]   2> 5194 T1118 oasc.CoreContainer.<init> New CoreContainer 4504189
[junit4:junit4]   2> 5194 T1118 oasc.CoreContainer.load Loading CoreContainer using Solr Home: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-jetty1-1360042963669\'
[junit4:junit4]   2> 5194 T1118 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-jetty1-1360042963669\'
[junit4:junit4]   2> 5252 T1118 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 60000
[junit4:junit4]   2> 5253 T1118 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 5253 T1118 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4:junit4]   2> 5254 T1118 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 5254 T1118 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 5254 T1118 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 5255 T1118 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 5255 T1118 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 5255 T1118 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 5255 T1118 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=60000&connTimeout=15000&retry=false
[junit4:junit4]   2> 5275 T1118 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 5312 T1118 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:53320/solr
[junit4:junit4]   2> 5313 T1118 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4:junit4]   2> 5313 T1118 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:53320 sessionTimeout=60000 watcher=org.apache.solr.common.cloud.ConnectionManager@1a9d07e
[junit4:junit4]   2> 5315 T1118 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 5317 T1156 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server 127.0.0.1/127.0.0.1:53320. Will not attempt to authenticate using SASL (access denied ("javax.security.auth.AuthPermission" "getLoginConfiguration"))
[junit4:junit4]   2> 5318 T1156 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to 127.0.0.1/127.0.0.1:53320, initiating session
[junit4:junit4]   2> 5318 T1120 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:53344
[junit4:junit4]   2> 5318 T1120 oazs.ZooKeeperServer.processConnectRequest Client attempting to establish new session at /127.0.0.1:53344
[junit4:junit4]   2> 5348 T1122 oazs.ZooKeeperServer.finishSessionInit Established session 0x13ca8e0a0520005 with negotiated timeout 20000 for client /127.0.0.1:53344
[junit4:junit4]   2> 5348 T1156 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server 127.0.0.1/127.0.0.1:53320, sessionid = 0x13ca8e0a0520005, negotiated timeout = 20000
[junit4:junit4]   2> 5349 T1157 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1a9d07e name:ZooKeeperConnection Watcher:127.0.0.1:53320 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 5349 T1118 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 5352 T1123 oazs.PrepRequestProcessor.pRequest2Txn Processed session termination for sessionid: 0x13ca8e0a0520005
[junit4:junit4]   2> 5364 T1157 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 5364 T1120 oazs.NIOServerCnxn.doIO WARNING caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x13ca8e0a0520005, likely client has closed socket
[junit4:junit4]   2> 	at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:220)
[junit4:junit4]   2> 	at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4:junit4]   2> 	at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 
[junit4:junit4]   2> 5365 T1120 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:53344 which had sessionid 0x13ca8e0a0520005
[junit4:junit4]   2> 5364 T1118 oaz.ZooKeeper.close Session: 0x13ca8e0a0520005 closed
[junit4:junit4]   2> 5367 T1118 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=500&maxConnectionsPerHost=16&socketTimeout=60000&connTimeout=15000
[junit4:junit4]   2> 5379 T1118 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:53320/solr sessionTimeout=30000 watcher=org.apache.solr.common.cloud.ConnectionManager@9cdbf4
[junit4:junit4]   2> 5383 T1118 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 5385 T1158 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server 127.0.0.1/127.0.0.1:53320. Will not attempt to authenticate using SASL (access denied ("javax.security.auth.AuthPermission" "getLoginConfiguration"))
[junit4:junit4]   2> 5387 T1158 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to 127.0.0.1/127.0.0.1:53320, initiating session
[junit4:junit4]   2> 5389 T1120 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:53347
[junit4:junit4]   2> 5390 T1120 oazs.ZooKeeperServer.processConnectRequest Client attempting to establish new session at /127.0.0.1:53347
[junit4:junit4]   2> 5394 T1158 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server 127.0.0.1/127.0.0.1:53320, sessionid = 0x13ca8e0a0520006, negotiated timeout = 20000
[junit4:junit4]   2> 5394 T1122 oazs.ZooKeeperServer.finishSessionInit Established session 0x13ca8e0a0520006 with negotiated timeout 20000 for client /127.0.0.1:53347
[junit4:junit4]   2> 5394 T1159 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@9cdbf4 name:ZooKeeperConnection Watcher:127.0.0.1:53320/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 5395 T1118 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 5399 T1123 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ca8e0a0520006 type:create cxid:0x1 zxid:0x49 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5404 T1123 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ca8e0a0520006 type:create cxid:0x2 zxid:0x4a txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5409 T1118 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:53339__vua
[junit4:junit4]   2> 5412 T1123 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ca8e0a0520006 type:delete cxid:0x4 zxid:0x4b txntype:-1 reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:53339__vua Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:53339__vua
[junit4:junit4]   2> 5414 T1118 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:53339__vua
[junit4:junit4]   2> 5433 T1140 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1)
[junit4:junit4]   2> 5437 T1146 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4:junit4]   2> 5441 T1140 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4:junit4]   2> 5459 T1118 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 5486 T1160 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-jetty1-1360042963669\collection1
[junit4:junit4]   2> 5487 T1160 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 5489 T1160 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 5489 T1160 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 5496 T1160 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-jetty1-1360042963669\collection1\'
[junit4:junit4]   2> 5501 T1160 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-jetty1-1360042963669/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 5503 T1160 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-jetty1-1360042963669/collection1/lib/README' to classloader
[junit4:junit4]   2> 5595 T1160 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 5705 T1160 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 5708 T1160 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 5722 T1160 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 6295 T1141 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 6296 T1141 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "numShards":"1",
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "state":"active",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "collection":"control_collection",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:53327__vua",
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:53327/_vua"}
[junit4:junit4]   2> 6324 T1159 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4:junit4]   2> 6326 T1140 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4:junit4]   2> 6326 T1146 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4:junit4]   2> 6714 T1160 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 6730 T1160 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 6737 T1160 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 6760 T1160 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 6767 T1160 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 6772 T1160 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 6774 T1160 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 6775 T1160 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-jetty1-1360042963669\collection1\, dataDir=.\org.apache.solr.cloud.RecoveryZkTest-1360042958916/jetty1\
[junit4:junit4]   2> 6776 T1160 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@f4daba
[junit4:junit4]   2> 6776 T1160 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 6777 T1160 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\jetty1 forceNew:false
[junit4:junit4]   2> 6777 T1160 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\jetty1
[junit4:junit4]   2> 6777 T1160 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=.\org.apache.solr.cloud.RecoveryZkTest-1360042958916/jetty1\index/
[junit4:junit4]   2> 6779 T1160 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\jetty1\index' doesn't exist. Creating new index...
[junit4:junit4]   2> 6780 T1160 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\jetty1\index forceNew:false
[junit4:junit4]   2> 6783 T1160 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@30e814 lockFactory=org.apache.lucene.store.NativeFSLockFactory@4f4101)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 6783 T1160 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 6785 T1160 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\jetty1\index
[junit4:junit4]   2> 6785 T1160 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 6788 T1160 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 6788 T1160 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 6789 T1160 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 6789 T1160 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 6789 T1160 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 6790 T1160 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 6790 T1160 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 6791 T1160 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 6791 T1160 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 6792 T1160 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 6800 T1160 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 6801 T1160 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 6801 T1160 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 6801 T1160 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 6802 T1160 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 6803 T1160 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 6803 T1160 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6804 T1160 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6804 T1160 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6805 T1160 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6806 T1160 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6806 T1160 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6808 T1160 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6808 T1160 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6810 T1160 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 6810 T1160 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 6822 T1160 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 6828 T1160 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 6829 T1160 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SCHEMA.XML, OLD_SYNONYMS.TXT, STOPWORDS.TXT, PROTWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, SYNONYMS.TXT, CURRENCY.XML, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 6832 T1160 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\jetty1
[junit4:junit4]   2> 6832 T1160 oass.SolrIndexSearcher.<init> Opening Searcher@f92619 main
[junit4:junit4]   2> 6834 T1160 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 6834 T1160 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 6834 T1160 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 6883 T1160 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 7157 T1161 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@f92619 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 7163 T1160 oasc.ZkController.publish publishing core=collection1 state=down
[junit4:junit4]   2> 7163 T1160 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 8001 T1141 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 8002 T1141 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "numShards":"1",
[junit4:junit4]   2> 	  "shard":null,
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "state":"down",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:53339__vua",
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:53339/_vua"}
[junit4:junit4]   2> 8002 T1141 oasc.Overseer$ClusterStateUpdater.createCollection Create collection collection1 with numShards 1
[junit4:junit4]   2> 8002 T1141 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1
[junit4:junit4]   2> 8024 T1159 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4:junit4]   2> 8024 T1140 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4:junit4]   2> 8024 T1146 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4:junit4]   2> 8257 T1160 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 8257 T1160 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:53339/_vua collection:collection1 shard:shard1
[junit4:junit4]   2> 8261 T1160 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election
[junit4:junit4]   2> 8286 T1123 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ca8e0a0520006 type:delete cxid:0x45 zxid:0x5b txntype:-1 reqpath:n/a Error Path:/solr/collections/collection1/leaders Error:KeeperErrorCode = NoNode for /solr/collections/collection1/leaders
[junit4:junit4]   2> 8305 T1160 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 8306 T1123 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ca8e0a0520006 type:create cxid:0x46 zxid:0x5c txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 8320 T1160 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4]   2> 8320 T1160 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 8322 T1160 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:53339/_vua/collection1/
[junit4:junit4]   2> 8322 T1160 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4:junit4]   2> 8322 T1160 oasc.SyncStrategy.syncToMe http://127.0.0.1:53339/_vua/collection1/ has no replicas
[junit4:junit4]   2> 8323 T1160 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:53339/_vua/collection1/
[junit4:junit4]   2> 8323 T1160 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4:junit4]   2> 8348 T1123 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ca8e0a0520006 type:create cxid:0x50 zxid:0x60 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 9521 T1141 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 9640 T1146 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4:junit4]   2> 9640 T1159 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4:junit4]   2> 9640 T1140 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4:junit4]   2> 9676 T1160 oasc.ZkController.register We are http://127.0.0.1:53339/_vua/collection1/ and leader is http://127.0.0.1:53339/_vua/collection1/
[junit4:junit4]   2> 9676 T1160 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:53339/_vua
[junit4:junit4]   2> 9676 T1160 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4]   2> 9676 T1160 oasc.ZkController.publish publishing core=collection1 state=active
[junit4:junit4]   2> 9677 T1160 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 9702 T1160 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 9713 T1118 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4:junit4]   2> 9714 T1118 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 9715 T1118 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 10121 T1118 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 10124 T1118 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:53348
[junit4:junit4]   2> 10125 T1118 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 10125 T1118 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 10125 T1118 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-jetty2-1360042968649
[junit4:junit4]   2> 10126 T1118 oasc.CoreContainer$Initializer.initialize looking for solr.xml: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-jetty2-1360042968649\solr.xml
[junit4:junit4]   2> 10126 T1118 oasc.CoreContainer.<init> New CoreContainer 1784248
[junit4:junit4]   2> 10127 T1118 oasc.CoreContainer.load Loading CoreContainer using Solr Home: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-jetty2-1360042968649\'
[junit4:junit4]   2> 10128 T1118 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-jetty2-1360042968649\'
[junit4:junit4]   2> 10174 T1118 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 60000
[junit4:junit4]   2> 10174 T1118 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 10175 T1118 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4:junit4]   2> 10175 T1118 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 10175 T1118 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 10176 T1118 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 10176 T1118 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 10177 T1118 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 10177 T1118 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 10177 T1118 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=60000&connTimeout=15000&retry=false
[junit4:junit4]   2> 10192 T1118 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 10221 T1118 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:53320/solr
[junit4:junit4]   2> 10222 T1118 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4:junit4]   2> 10222 T1118 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:53320 sessionTimeout=60000 watcher=org.apache.solr.common.cloud.ConnectionManager@13206f1
[junit4:junit4]   2> 10224 T1118 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 10226 T1171 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server 127.0.0.1/127.0.0.1:53320. Will not attempt to authenticate using SASL (access denied ("javax.security.auth.AuthPermission" "getLoginConfiguration"))
[junit4:junit4]   2> 10227 T1171 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to 127.0.0.1/127.0.0.1:53320, initiating session
[junit4:junit4]   2> 10227 T1120 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:53353
[junit4:junit4]   2> 10231 T1120 oazs.ZooKeeperServer.processConnectRequest Client attempting to establish new session at /127.0.0.1:53353
[junit4:junit4]   2> 10249 T1122 oazs.ZooKeeperServer.finishSessionInit Established session 0x13ca8e0a0520007 with negotiated timeout 20000 for client /127.0.0.1:53353
[junit4:junit4]   2> 10249 T1171 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server 127.0.0.1/127.0.0.1:53320, sessionid = 0x13ca8e0a0520007, negotiated timeout = 20000
[junit4:junit4]   2> 10250 T1172 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@13206f1 name:ZooKeeperConnection Watcher:127.0.0.1:53320 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 10250 T1118 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 10253 T1123 oazs.PrepRequestProcessor.pRequest2Txn Processed session termination for sessionid: 0x13ca8e0a0520007
[junit4:junit4]   2> 10256 T1118 oaz.ZooKeeper.close Session: 0x13ca8e0a0520007 closed
[junit4:junit4]   2> 10256 T1120 oazs.NIOServerCnxn.doIO WARNING caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x13ca8e0a0520007, likely client has closed socket
[junit4:junit4]   2> 	at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:220)
[junit4:junit4]   2> 	at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4:junit4]   2> 	at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 
[junit4:junit4]   2> 10256 T1172 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 10256 T1118 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=500&maxConnectionsPerHost=16&socketTimeout=60000&connTimeout=15000
[junit4:junit4]   2> 10258 T1120 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:53353 which had sessionid 0x13ca8e0a0520007
[junit4:junit4]   2> 10262 T1118 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:53320/solr sessionTimeout=30000 watcher=org.apache.solr.common.cloud.ConnectionManager@ff50cb
[junit4:junit4]   2> 10264 T1118 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 10265 T1173 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server 127.0.0.1/127.0.0.1:53320. Will not attempt to authenticate using SASL (access denied ("javax.security.auth.AuthPermission" "getLoginConfiguration"))
[junit4:junit4]   2> 10266 T1173 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to 127.0.0.1/127.0.0.1:53320, initiating session
[junit4:junit4]   2> 10266 T1120 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:53356
[junit4:junit4]   2> 10267 T1120 oazs.ZooKeeperServer.processConnectRequest Client attempting to establish new session at /127.0.0.1:53356
[junit4:junit4]   2> 10269 T1122 oazs.ZooKeeperServer.finishSessionInit Established session 0x13ca8e0a0520008 with negotiated timeout 20000 for client /127.0.0.1:53356
[junit4:junit4]   2> 10269 T1173 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server 127.0.0.1/127.0.0.1:53320, sessionid = 0x13ca8e0a0520008, negotiated timeout = 20000
[junit4:junit4]   2> 10269 T1174 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@ff50cb name:ZooKeeperConnection Watcher:127.0.0.1:53320/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 10270 T1118 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 10272 T1123 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ca8e0a0520008 type:create cxid:0x1 zxid:0x6d txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 10286 T1123 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ca8e0a0520008 type:create cxid:0x2 zxid:0x6e txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 10289 T1118 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:53348__vua
[junit4:junit4]   2> 10289 T1123 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13ca8e0a0520008 type:delete cxid:0x4 zxid:0x6f txntype:-1 reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:53348__vua Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:53348__vua
[junit4:junit4]   2> 10291 T1118 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:53348__vua
[junit4:junit4]   2> 10295 T1159 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 2)
[junit4:junit4]   2> 10295 T1140 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 2)
[junit4:junit4]   2> 10296 T1146 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4]   2> 10297 T1146 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 3)
[junit4:junit4]   2> 10299 T1159 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4]   2> 10299 T1140 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4]   2> 10303 T1118 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 10313 T1175 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-jetty2-1360042968649\collection1
[junit4:junit4]   2> 10313 T1175 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 10314 T1175 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 10314 T1175 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 10317 T1175 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-jetty2-1360042968649\collection1\'
[junit4:junit4]   2> 10318 T1175 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-jetty2-1360042968649/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 10319 T1175 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/org.apache.solr.cloud.RecoveryZkTest-jetty2-1360042968649/collection1/lib/README' to classloader
[junit4:junit4]   2> 10389 T1175 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 10504 T1175 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 10505 T1175 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 10512 T1175 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 11204 T1141 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 11204 T1141 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "numShards":"1",
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "state":"active",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:53339__vua",
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:53339/_vua"}
[junit4:junit4]   2> 11222 T1174 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4:junit4]   2> 11223 T1146 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4:junit4]   2> 11223 T1140 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4:junit4]   2> 11225 T1159 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4:junit4]   2> 11400 T1175 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 11410 T1175 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 11414 T1175 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 11432 T1175 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 11440 T1175 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 11451 T1175 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 11453 T1175 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 11462 T1175 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-jetty2-1360042968649\collection1\, dataDir=.\org.apache.solr.cloud.RecoveryZkTest-1360042958916/jetty2\
[junit4:junit4]   2> 11463 T1175 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@f4daba
[junit4:junit4]   2> 11463 T1175 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 11464 T1175 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\jetty2 forceNew:false
[junit4:junit4]   2> 11464 T1175 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\jetty2
[junit4:junit4]   2> 11464 T1175 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=.\org.apache.solr.cloud.RecoveryZkTest-1360042958916/jetty2\index/
[junit4:junit4]   2> 11465 T1175 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\jetty2\index' doesn't exist. Creating new index...
[junit4:junit4]   2> 11466 T1175 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\jetty2\index forceNew:false
[junit4:junit4]   2> 11469 T1175 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@62fafb lockFactory=org.apache.lucene.store.NativeFSLockFactory@1eeb0f)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 11469 T1175 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 11471 T1175 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\jetty2\index
[junit4:junit4]   2> 11472 T1175 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 11474 T1175 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 11474 T1175 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 11475 T1175 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 11475 T1175 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 11475 T1175 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 11476 T1175 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 11476 T1175 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 11476 T1175 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 11477 T1175 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 11478 T1175 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 11478 T1175 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 11479 T1175 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 11479 T1175 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 11479 T1175 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 11480 T1175 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 11480 T1175 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 11481 T1175 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 11481 T1175 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 11482 T1175 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 11482 T1175 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 11483 T1175 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 11483 T1175 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 11483 T1175 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 11483 T1175 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 11484 T1175 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 11485 T1175 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 11495 T1175 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 11501 T1175 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 11502 T1175 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SCHEMA.XML, OLD_SYNONYMS.TXT, STOPWORDS.TXT, PROTWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, SYNONYMS.TXT, CURRENCY.XML, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 11504 T1175 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\jetty2
[junit4:junit4]   2> 11505 T1175 oass.SolrIndexSearcher.<init> Opening Searcher@e76a37 main
[junit4:junit4]   2> 11507 T1175 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 11507 T1175 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 11507 T1175 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 11566 T1175 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 11799 T1176 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@e76a37 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 11804 T1175 oasc.ZkController.publish publishing core=collection1 state=down
[junit4:junit4]   2> 11804 T1175 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 12726 T1141 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 12729 T1141 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "numShards":"1",
[junit4:junit4]   2> 	  "shard":null,
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "state":"down",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:53348__vua",
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:53348/_vua"}
[junit4:junit4]   2> 12730 T1141 oasc.Overseer$ClusterStateUpdater.updateState Collection already exists with numShards=1
[junit4:junit4]   2> 12730 T1141 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1
[junit4:junit4]   2> 12750 T1146 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4:junit4]   2> 12750 T1159 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4:junit4]   2> 12751 T1140 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4:junit4]   2> 12750 T1174 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4:junit4]   2> 12796 T1175 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 12796 T1175 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:53348/_vua collection:collection1 shard:shard1
[junit4:junit4]   2> 12803 T1175 oasc.ZkController.register We are http://127.0.0.1:53348/_vua/collection1/ and leader is http://127.0.0.1:53339/_vua/collection1/
[junit4:junit4]   2> 12803 T1175 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:53348/_vua
[junit4:junit4]   2> 12803 T1175 oasc.ZkController.checkRecovery Core needs to recover:collection1
[junit4:junit4]   2> 12803 T1175 oasu.DefaultSolrCoreState.doRecovery Running recovery - first canceling any ongoing recovery
[junit4:junit4]   2> ASYNC  NEW_CORE C99 name=collection1 org.apache.solr.core.SolrCore@7ae4f7 url=http://127.0.0.1:53348/_vua/collection1 node=127.0.0.1:53348__vua C99_STATE=coll:collection1 core:collection1 props:{shard=null, roles=null, state=down, core=collection1, collection=collection1, node_name=127.0.0.1:53348__vua, base_url=http://127.0.0.1:53348/_vua}
[junit4:junit4]   2> 12804 T1177 C99 P53348 oasc.RecoveryStrategy.run Starting recovery process.  core=collection1 recoveringAfterStartup=true
[junit4:junit4]   2> 12805 T1177 C99 P53348 oasc.RecoveryStrategy.doRecovery ###### startupVersions=[]
[junit4:junit4]   2> 12805 T1175 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 12805 T1177 C99 P53348 oasc.ZkController.publish publishing core=collection1 state=recovering
[junit4:junit4]   2> 12805 T1177 C99 P53348 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 12806 T1118 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4:junit4]   2> 12807 T1118 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 12807 T1118 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 12810 T1177 C99 P53348 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 12823 T1118 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> ASYNC  NEW_CORE C100 name=collection1 org.apache.solr.core.SolrCore@8ab368 url=http://127.0.0.1:53327/_vua/collection1 node=127.0.0.1:53327__vua C100_STATE=coll:control_collection core:collection1 props:{shard=shard1, roles=null, state=active, core=collection1, collection=control_collection, node_name=127.0.0.1:53327__vua, base_url=http://127.0.0.1:53327/_vua, leader=true}
[junit4:junit4]   2> 12840 T1131 C100 P53327 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\control\data
[junit4:junit4]   2> 12845 T1131 C100 P53327 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@85b2ea lockFactory=org.apache.lucene.store.NativeFSLockFactory@b4b4a0)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 12846 T1131 C100 P53327 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 12849 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[10001 (1426108419146776576)]} 0 10
[junit4:junit4]   2> 12849 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[1 (1426108419146776577)]} 0 10
[junit4:junit4]   2> ASYNC  NEW_CORE C101 name=collection1 org.apache.solr.core.SolrCore@f7d9d4 url=http://127.0.0.1:53339/_vua/collection1 node=127.0.0.1:53339__vua C101_STATE=coll:collection1 core:collection1 props:{shard=shard1, roles=null, state=active, core=collection1, collection=collection1, node_name=127.0.0.1:53339__vua, base_url=http://127.0.0.1:53339/_vua, leader=true}
[junit4:junit4]   2> 12860 T1153 C101 P53339 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\jetty1
[junit4:junit4]   2> 12866 T1153 C101 P53339 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@30e814 lockFactory=org.apache.lucene.store.NativeFSLockFactory@4f4101)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 12867 T1153 C101 P53339 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 12872 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[1 (1426108419169845248)]} 0 11
[junit4:junit4]   2> 12872 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10001 (1426108419166699520)]} 0 13
[junit4:junit4]   2> 12876 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[2 (1426108419184525312)]} 0 1
[junit4:junit4]   2> 12877 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10002 (1426108419184525313)]} 0 2
[junit4:junit4]   2> 12880 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[2 (1426108419187671041)]} 0 1
[junit4:junit4]   2> 12880 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10002 (1426108419187671040)]} 0 1
[junit4:junit4]   2> 12896 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[3 (1426108419190816768)]} 0 14
[junit4:junit4]   2> 12897 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[10003 (1426108419204448256)]} 0 15
[junit4:junit4]   2> 12903 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[3 (1426108419209691136)]} 0 3
[junit4:junit4]   2> 12903 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10003 (1426108419211788288)]} 0 1
[junit4:junit4]   2> 12906 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10004 (1426108419215982592)]} 0 0
[junit4:junit4]   2> 12907 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[4 (1426108419215982593)]} 0 1
[junit4:junit4]   2> 12909 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10004 (1426108419219128320)]} 0 0
[junit4:junit4]   2> 12910 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[4 (1426108419220176896)]} 0 0
[junit4:junit4]   2> 12911 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[10005 (1426108419221225472)]} 0 0
[junit4:junit4]   2> 12915 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10005 (1426108419225419776)]} 0 0
[junit4:junit4]   2> 12916 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[5 (1426108419223322624)]} 0 3
[junit4:junit4]   2> 12919 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[10006 (1426108419228565504)]} 0 1
[junit4:junit4]   2> 12925 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[5 (1426108419229614080)]} 0 6
[junit4:junit4]   2> 12925 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10006 (1426108419233808384)]} 0 3
[junit4:junit4]   2> 12929 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[10007 (1426108419239051264)]} 0 1
[junit4:junit4]   2> 12930 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[6 (1426108419239051265)]} 0 2
[junit4:junit4]   2> 12932 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10007 (1426108419243245568)]} 0 0
[junit4:junit4]   2> 12933 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[6 (1426108419243245569)]} 0 1
[junit4:junit4]   2> 12935 T1131 C100 P53327 /update {wt=javabin&version=2} {delete=[10001 (-1426108419246391296)]} 0 0
[junit4:junit4]   2> 12935 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[7 (1426108419246391297)]} 0 0
[junit4:junit4]   2> 12937 T1154 C101 P53339 /update {wt=javabin&version=2} {delete=[10001 (-1426108419248488448)]} 0 0
[junit4:junit4]   2> 12938 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[7 (1426108419249537024)]} 0 0
[junit4:junit4]   2> 12939 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10008 (1426108419250585600)]} 0 0
[junit4:junit4]   2> 12940 T1136 C100 P53327 /update {wt=javabin&version=2} {delete=[1 (-1426108419251634176)]} 0 0
[junit4:junit4]   2> 12941 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10008 (1426108419252682752)]} 0 0
[junit4:junit4]   2> 12943 T1152 C101 P53339 /update {wt=javabin&version=2} {delete=[1 (-1426108419254779904)]} 0 0
[junit4:junit4]   2> 12948 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[8 (1426108419260022784)]} 0 0
[junit4:junit4]   2> 12949 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10009 (1426108419261071360)]} 0 0
[junit4:junit4]   2> 12951 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[8 (1426108419263168512)]} 0 0
[junit4:junit4]   2> 12952 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10009 (1426108419264217088)]} 0 0
[junit4:junit4]   2> 12954 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[9 (1426108419266314240)]} 0 0
[junit4:junit4]   2> 12955 T1132 C100 P53327 /update {wt=javabin&version=2} {delete=[10002 (-1426108419267362816)]} 0 0
[junit4:junit4]   2> 12958 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[9 (1426108419269459968)]} 0 1
[junit4:junit4]   2> 12958 T1153 C101 P53339 /update {wt=javabin&version=2} {delete=[10002 (-1426108419270508544)]} 0 0
[junit4:junit4]   2> 12960 T1133 C100 P53327 /update {wt=javabin&version=2} {delete=[2 (-1426108419272605696)]} 0 0
[junit4:junit4]   2> 12963 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[10010 (1426108419274702848)]} 0 1
[junit4:junit4]   2> 12963 T1152 C101 P53339 /update {wt=javabin&version=2} {delete=[2 (-1426108419275751424)]} 0 0
[junit4:junit4]   2> 12966 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[10010 (1426108419277848576)]} 0 1
[junit4:junit4]   2> 12968 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[10 (1426108419278897152)]} 0 2
[junit4:junit4]   2> 12973 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10011 (1426108419285188608)]} 0 1
[junit4:junit4]   2> 12976 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10011 (1426108419288334336)]} 0 1
[junit4:junit4]   2> 12978 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10 (1426108419287285760)]} 0 4
[junit4:junit4]   2> 12981 T1131 C100 P53327 /update {wt=javabin&version=2} {delete=[10003 (-1426108419294625792)]} 0 1
[junit4:junit4]   2> 12983 T1153 C101 P53339 /update {wt=javabin&version=2} {delete=[10003 (-1426108419296722944)]} 0 0
[junit4:junit4]   2> 12984 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[11 (1426108419296722944)]} 0 1
[junit4:junit4]   2> 12989 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[11 (1426108419303014400)]} 0 0
[junit4:junit4]   2> 12989 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10012 (1426108419303014400)]} 0 0
[junit4:junit4]   2> 12993 T1136 C100 P53327 /update {wt=javabin&version=2} {delete=[3 (-1426108419307208704)]} 0 0
[junit4:junit4]   2> 12994 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[10012 (1426108419307208704)]} 0 1
[junit4:junit4]   2> 12995 T1151 C101 P53339 /update {wt=javabin&version=2} {delete=[3 (-1426108419309305856)]} 0 0
[junit4:junit4]   2> 12996 T1134 C100 P53327 /update {wt=javabin&version=2} {delete=[10004 (-1426108419310354432)]} 0 0
[junit4:junit4]   2> 13010 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[12 (1426108419323985920)]} 0 1
[junit4:junit4]   2> 13011 T1154 C101 P53339 /update {wt=javabin&version=2} {delete=[10004 (-1426108419326083072)]} 0 0
[junit4:junit4]   2> 13013 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[12 (1426108419328180224)]} 0 0
[junit4:junit4]   2> 13014 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[10013 (1426108419329228800)]} 0 0
[junit4:junit4]   2> 13016 T1132 C100 P53327 /update {wt=javabin&version=2} {delete=[4 (-1426108419331325952)]} 0 0
[junit4:junit4]   2> 13017 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10013 (1426108419332374528)]} 0 0
[junit4:junit4]   2> 13019 T1155 C101 P53339 /update {wt=javabin&version=2} {delete=[4 (-1426108419334471680)]} 0 0
[junit4:junit4]   2> 13020 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10014 (1426108419335520256)]} 0 0
[junit4:junit4]   2> 13022 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[13 (1426108419337617408)]} 0 0
[junit4:junit4]   2> 13024 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10014 (1426108419339714560)]} 0 0
[junit4:junit4]   2> 13026 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[13 (1426108419341811712)]} 0 0
[junit4:junit4]   2> 13027 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[10015 (1426108419342860288)]} 0 0
[junit4:junit4]   2> 13028 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[14 (1426108419343908864)]} 0 0
[junit4:junit4]   2> 13029 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10015 (1426108419344957440)]} 0 0
[junit4:junit4]   2> 13031 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[14 (1426108419347054592)]} 0 0
[junit4:junit4]   2> 13036 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[15 (1426108419351248896)]} 0 1
[junit4:junit4]   2> 13038 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[10016 (1426108419349151744)]} 0 5
[junit4:junit4]   2> 13042 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10016 (1426108419357540352)]} 0 1
[junit4:junit4]   2> 13044 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[15 (1426108419356491776)]} 0 4
[junit4:junit4]   2> 13045 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10017 (1426108419361734656)]} 0 0
[junit4:junit4]   2> 13048 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[16 (1426108419363831808)]} 0 1
[junit4:junit4]   2> 13050 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10017 (1426108419366977536)]} 0 1
[junit4:junit4]   2> 13052 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[16 (1426108419369074688)]} 0 1
[junit4:junit4]   2> 13054 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[10018 (1426108419371171840)]} 0 1
[junit4:junit4]   2> 13056 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[17 (1426108419373268992)]} 0 1
[junit4:junit4]   2> 13058 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10018 (1426108419374317568)]} 0 1
[junit4:junit4]   2> 13060 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[17 (1426108419376414720)]} 0 1
[junit4:junit4]   2> 13061 T1132 C100 P53327 /update {wt=javabin&version=2} {delete=[10005 (-1426108419378511872)]} 0 0
[junit4:junit4]   2> 13064 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[18 (1426108419380609024)]} 0 1
[junit4:junit4]   2> 13066 T1155 C101 P53339 /update {wt=javabin&version=2} {delete=[10005 (-1426108419383754752)]} 0 0
[junit4:junit4]   2> 13070 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[18 (1426108419385851904)]} 0 2
[junit4:junit4]   2> 13072 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10019 (1426108419388997632)]} 0 1
[junit4:junit4]   2> 13073 T1136 C100 P53327 /update {wt=javabin&version=2} {delete=[5 (-1426108419391094784)]} 0 0
[junit4:junit4]   2> 13076 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10019 (1426108419393191936)]} 0 1
[junit4:junit4]   2> 13077 T1152 C101 P53339 /update {wt=javabin&version=2} {delete=[5 (-1426108419395289088)]} 0 0
[junit4:junit4]   2> 13080 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[10020 (1426108419397386240)]} 0 1
[junit4:junit4]   2> 13082 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[19 (1426108419399483392)]} 0 1
[junit4:junit4]   2> 13084 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10020 (1426108419401580544)]} 0 1
[junit4:junit4]   2> 13085 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[19 (1426108419403677696)]} 0 0
[junit4:junit4]   2> 13087 T1132 C100 P53327 /update {wt=javabin&version=2} {delete=[10006 (-1426108419405774848)]} 0 0
[junit4:junit4]   2> 13092 T1154 C101 P53339 /update {wt=javabin&version=2} {delete=[10006 (-1426108419411017728)]} 0 2
[junit4:junit4]   2> 13097 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10021 (1426108419414163456)]} 0 2
[junit4:junit4]   2> 13098 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[20 (1426108419411017728)]} 0 8
[junit4:junit4]   2> 13102 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[20 (1426108419420454912)]} 0 1
[junit4:junit4]   2> 13105 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10021 (1426108419419406336)]} 0 5
[junit4:junit4]   2> 13105 T1136 C100 P53327 /update {wt=javabin&version=2} {delete=[6 (-1426108419424649216)]} 0 0
[junit4:junit4]   2> 13109 T1151 C101 P53339 /update {wt=javabin&version=2} {delete=[6 (-1426108419428843520)]} 0 0
[junit4:junit4]   2> 13109 T1135 C100 P53327 /update {wt=javabin&version=2} {delete=[10009 (-1426108419428843520)]} 0 0
[junit4:junit4]   2> 13112 T1155 C101 P53339 /update {wt=javabin&version=2} {delete=[10009 (-1426108419431989248)]} 0 0
[junit4:junit4]   2> 13113 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[21 (1426108419431989248)]} 0 1
[junit4:junit4]   2> 13123 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[21 (1426108419443523584)]} 0 9
[junit4:junit4]   2> 13123 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[10022 (1426108419443523584)]} 0 0
[junit4:junit4]   2> 13126 T1133 C100 P53327 /update {wt=javabin&version=2} {delete=[9 (-1426108419446669312)]} 0 0
[junit4:junit4]   2> 13126 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10022 (1426108419446669312)]} 0 0
[junit4:junit4]   2> 13129 T1153 C101 P53339 /update {wt=javabin&version=2} {delete=[9 (-1426108419449815040)]} 0 0
[junit4:junit4]   2> 13130 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[10023 (1426108419450863616)]} 0 0
[junit4:junit4]   2> 13132 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[22 (1426108419452960768)]} 0 0
[junit4:junit4]   2> 13133 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10023 (1426108419454009344)]} 0 0
[junit4:junit4]   2> 13136 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[22 (1426108419457155072)]} 0 0
[junit4:junit4]   2> 13136 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10024 (1426108419457155072)]} 0 0
[junit4:junit4]   2> 13139 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[23 (1426108419460300800)]} 0 0
[junit4:junit4]   2> 13140 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10024 (1426108419460300800)]} 0 1
[junit4:junit4]   2> 13143 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[23 (1426108419463446528)]} 0 1
[junit4:junit4]   2> 13143 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[10025 (1426108419464495104)]} 0 0
[junit4:junit4]   2> 13147 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[24 (1426108419467640832)]} 0 1
[junit4:junit4]   2> 13148 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10025 (1426108419468689408)]} 0 1
[junit4:junit4]   2> 13149 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[24 (1426108419470786560)]} 0 0
[junit4:junit4]   2> 13150 T1131 C100 P53327 /update {wt=javabin&version=2} {delete=[10013 (-1426108419471835136)]} 0 0
[junit4:junit4]   2> 13152 T1155 C101 P53339 /update {wt=javabin&version=2} {delete=[10013 (-1426108419473932288)]} 0 0
[junit4:junit4]   2> 13157 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10026 (1426108419478126592)]} 0 1
[junit4:junit4]   2> 13157 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[25 (1426108419473932288)]} 0 5
[junit4:junit4]   2> 13162 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10026 (1426108419483369473)]} 0 1
[junit4:junit4]   2> 13163 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[25 (1426108419483369472)]} 0 2
[junit4:junit4]   2> 13164 T1134 C100 P53327 /update {wt=javabin&version=2} {delete=[10014 (-1426108419486515200)]} 0 0
[junit4:junit4]   2> 13166 T1153 C101 P53339 /update {wt=javabin&version=2} {delete=[10014 (-1426108419488612352)]} 0 0
[junit4:junit4]   2> 13166 T1132 C100 P53327 /update {wt=javabin&version=2} {delete=[13 (-1426108419488612352)]} 0 0
[junit4:junit4]   2> 13169 T1151 C101 P53339 /update {wt=javabin&version=2} {delete=[13 (-1426108419491758080)]} 0 0
[junit4:junit4]   2> 13169 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10027 (1426108419491758080)]} 0 0
[junit4:junit4]   2> 13171 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[26 (1426108419493855232)]} 0 0
[junit4:junit4]   2> 13172 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[10027 (1426108419494903808)]} 0 0
[junit4:junit4]   2> 13174 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[26 (1426108419497000960)]} 0 0
[junit4:junit4]   2> 13176 T1136 C100 P53327 /update {wt=javabin&version=2} {delete=[10015 (-1426108419499098112)]} 0 0
[junit4:junit4]   2> 13177 T1135 C100 P53327 /update {wt=javabin&version=2} {delete=[14 (-1426108419500146688)]} 0 0
[junit4:junit4]   2> 13178 T1154 C101 P53339 /update {wt=javabin&version=2} {delete=[10015 (-1426108419501195264)]} 0 0
[junit4:junit4]   2> 13180 T1153 C101 P53339 /update {wt=javabin&version=2} {delete=[14 (-1426108419503292416)]} 0 0
[junit4:junit4]   2> 13181 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[10028 (1426108419504340992)]} 0 0
[junit4:junit4]   2> 13183 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[27 (1426108419506438144)]} 0 0
[junit4:junit4]   2> 13184 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10028 (1426108419507486720)]} 0 0
[junit4:junit4]   2> 13186 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[27 (1426108419509583872)]} 0 0
[junit4:junit4]   2> 13188 T1133 C100 P53327 /update {wt=javabin&version=2} {delete=[10017 (-1426108419511681024)]} 0 0
[junit4:junit4]   2> 13190 T1131 C100 P53327 /update {wt=javabin&version=2} {delete=[15 (-1426108419513778176)]} 0 0
[junit4:junit4]   2> 13191 T1152 C101 P53339 /update {wt=javabin&version=2} {delete=[10017 (-1426108419514826752)]} 0 0
[junit4:junit4]   2> 13193 T1154 C101 P53339 /update {wt=javabin&version=2} {delete=[15 (-1426108419516923904)]} 0 0
[junit4:junit4]   2> 13195 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[10029 (1426108419517972480)]} 0 1
[junit4:junit4]   2> 13196 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[28 (1426108419520069632)]} 0 0
[junit4:junit4]   2> 13198 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10029 (1426108419521118208)]} 0 1
[junit4:junit4]   2> 13201 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[10030 (1426108419524263936)]} 0 1
[junit4:junit4]   2> 13201 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[28 (1426108419525312512)]} 0 0
[junit4:junit4]   2> 13203 T1132 C100 P53327 /update {wt=javabin&version=2} {delete=[17 (-1426108419527409664)]} 0 0
[junit4:junit4]   2> 13203 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[10030 (1426108419527409664)]} 0 0
[junit4:junit4]   2> 13207 T1152 C101 P53339 /update {wt=javabin&version=2} {delete=[17 (-1426108419531603968)]} 0 0
[junit4:junit4]   2> 13208 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10031 (1426108419531603968)]} 0 1
[junit4:junit4]   2> 13210 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10031 (1426108419534749696)]} 0 0
[junit4:junit4]   2> 13214 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[10032 (1426108419537895424)]} 0 1
[junit4:junit4]   2> 13215 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[29 (1426108419534749696)]} 0 5
[junit4:junit4]   2> 13219 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[29 (1426108419543138304)]} 0 1
[junit4:junit4]   2> 13231 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[30 (1426108419556769792)]} 0 1
[junit4:junit4]   2> 13231 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10032 (1426108419542089728)]} 0 14
[junit4:junit4]   2> 13233 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[10033 (1426108419558866944)]} 0 0
[junit4:junit4]   2> 13233 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[30 (1426108419558866944)]} 0 0
[junit4:junit4]   2> 13236 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[31 (1426108419562012672)]} 0 0
[junit4:junit4]   2> 13236 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10033 (1426108419562012672)]} 0 0
[junit4:junit4]   2> 13239 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[10034 (1426108419565158400)]} 0 0
[junit4:junit4]   2> 13240 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[31 (1426108419566206976)]} 0 0
[junit4:junit4]   2> 13242 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10034 (1426108419568304128)]} 0 0
[junit4:junit4]   2> 13243 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[32 (1426108419569352704)]} 0 0
[junit4:junit4]   2> 13245 T1134 C100 P53327 /update {wt=javabin&version=2} {delete=[10021 (-1426108419571449856)]} 0 0
[junit4:junit4]   2> 13246 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[32 (1426108419572498432)]} 0 0
[junit4:junit4]   2> 13247 T1152 C101 P53339 /update {wt=javabin&version=2} {delete=[10021 (-1426108419573547008)]} 0 0
[junit4:junit4]   2> 13249 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10035 (1426108419575644160)]} 0 0
[junit4:junit4]   2> 13249 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[33 (1426108419575644161)]} 0 0
[junit4:junit4]   2> 13252 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10035 (1426108419578789888)]} 0 0
[junit4:junit4]   2> 13253 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[33 (1426108419579838464)]} 0 0
[junit4:junit4]   2> 13255 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10036 (1426108419581935616)]} 0 0
[junit4:junit4]   2> 13258 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[34 (1426108419582984192)]} 0 2
[junit4:junit4]   2> 13259 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10036 (1426108419585081344)]} 0 1
[junit4:junit4]   2> 13261 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[10037 (1426108419588227072)]} 0 0
[junit4:junit4]   2> 13262 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[34 (1426108419587178496)]} 0 2
[junit4:junit4]   2> 13265 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10037 (1426108419591372800)]} 0 1
[junit4:junit4]   2> 13265 T1134 C100 P53327 /update {wt=javabin&version=2} {delete=[21 (-1426108419592421376)]} 0 0
[junit4:junit4]   2> 13267 T1132 C100 P53327 /update {wt=javabin&version=2} {delete=[10024 (-1426108419594518528)]} 0 0
[junit4:junit4]   2> 13268 T1154 C101 P53339 /update {wt=javabin&version=2} {delete=[21 (-1426108419595567104)]} 0 0
[junit4:junit4]   2> 13269 T1151 C101 P53339 /update {wt=javabin&version=2} {delete=[10024 (-1426108419596615680)]} 0 0
[junit4:junit4]   2> 13270 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[35 (1426108419597664256)]} 0 0
[junit4:junit4]   2> 13272 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10038 (1426108419599761408)]} 0 0
[junit4:junit4]   2> 13273 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[35 (1426108419600809984)]} 0 0
[junit4:junit4]   2> 13275 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[10038 (1426108419602907136)]} 0 0
[junit4:junit4]   2> 13277 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[36 (1426108419603955712)]} 0 1
[junit4:junit4]   2> 13278 T1131 C100 P53327 /update {wt=javabin&version=2} {delete=[10026 (-1426108419606052864)]} 0 0
[junit4:junit4]   2> 13279 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[36 (1426108419607101440)]} 0 0
[junit4:junit4]   2> 13281 T1154 C101 P53339 /update {wt=javabin&version=2} {delete=[10026 (-1426108419609198592)]} 0 0
[junit4:junit4]   2> 13282 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[37 (1426108419610247168)]} 0 0
[junit4:junit4]   2> 13284 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[10039 (1426108419612344320)]} 0 0
[junit4:junit4]   2> 13285 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[37 (1426108419613392896)]} 0 0
[junit4:junit4]   2> 13288 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10039 (1426108419615490048)]} 0 1
[junit4:junit4]   2> 13289 T1135 C100 P53327 /update {wt=javabin&version=2} {delete=[24 (-1426108419616538624)]} 0 0
[junit4:junit4]   2> 13289 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10040 (1426108419617587200)]} 0 0
[junit4:junit4]   2> 13290 T1155 C101 P53339 /update {wt=javabin&version=2} {delete=[24 (-1426108419618635776)]} 0 0
[junit4:junit4]   2> 13292 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10040 (1426108419620732928)]} 0 0
[junit4:junit4]   2> 13292 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[38 (1426108419620732928)]} 0 0
[junit4:junit4]   2> 13295 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[10041 (1426108419623878656)]} 0 0
[junit4:junit4]   2> 13295 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[38 (1426108419623878656)]} 0 0
[junit4:junit4]   2> 13298 T1134 C100 P53327 /update {wt=javabin&version=2} {delete=[26 (-1426108419627024384)]} 0 0
[junit4:junit4]   2> 13298 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10041 (1426108419627024384)]} 0 0
[junit4:junit4]   2> 13300 T1153 C101 P53339 /update {wt=javabin&version=2} {delete=[26 (-1426108419629121536)]} 0 0
[junit4:junit4]   2> 13303 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[39 (1426108419632267264)]} 0 0
[junit4:junit4]   2> 13305 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[10042 (1426108419631218688)]} 0 3
[junit4:junit4]   2> 13317 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10042 (1426108419637510144)]} 0 9
[junit4:junit4]   2> 13318 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[39 (1426108419635412992)]} 0 12
[junit4:junit4]   2> 13318 T1133 C100 P53327 /update {wt=javabin&version=2} {delete=[10029 (-1426108419647995904)]} 0 0
[junit4:junit4]   2> 13321 T1154 C101 P53339 /update {wt=javabin&version=2} {delete=[10029 (-1426108419651141632)]} 0 0
[junit4:junit4]   2> 13322 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[40 (1426108419651141632)]} 0 1
[junit4:junit4]   2> 13324 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[10043 (1426108419653238784)]} 0 1
[junit4:junit4]   2> 13324 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[40 (1426108419654287360)]} 0 0
[junit4:junit4]   2> 13326 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10043 (1426108419656384512)]} 0 0
[junit4:junit4]   2> 13327 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[41 (1426108419657433088)]} 0 0
[junit4:junit4]   2> 13329 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10044 (1426108419659530240)]} 0 0
[junit4:junit4]   2> 13330 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[41 (1426108419660578816)]} 0 0
[junit4:junit4]   2> 13332 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[10044 (1426108419662675968)]} 0 0
[junit4:junit4]   2> 13333 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[42 (1426108419663724544)]} 0 0
[junit4:junit4]   2> 13335 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10045 (1426108419665821696)]} 0 0
[junit4:junit4]   2> 13337 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[42 (1426108419667918848)]} 0 0
[junit4:junit4]   2> 13338 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10045 (1426108419668967424)]} 0 0
[junit4:junit4]   2> 13340 T1136 C100 P53327 /update {wt=javabin&version=2} {delete=[29 (-1426108419671064576)]} 0 0
[junit4:junit4]   2> 13341 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[10046 (1426108419672113152)]} 0 0
[junit4:junit4]   2> 13343 T1153 C101 P53339 /update {wt=javabin&version=2} {delete=[29 (-1426108419674210304)]} 0 0
[junit4:junit4]   2> 13344 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10046 (1426108419675258880)]} 0 0
[junit4:junit4]   2> 13346 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[43 (1426108419677356032)]} 0 0
[junit4:junit4]   2> 13349 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[43 (1426108419680501760)]} 0 0
[junit4:junit4]   2> 13357 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[44 (1426108419683647488)]} 0 5
[junit4:junit4]   2> 13365 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10047 (1426108419678404608)]} 0 18
[junit4:junit4]   2> 13383 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10047 (1426108419700424704)]} 0 15
[junit4:junit4]   2> 13386 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10048 (1426108419719299072)]} 0 0
[junit4:junit4]   2> 13389 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10048 (1426108419722444800)]} 0 0
[junit4:junit4]   2> 13392 T1136 C100 P53327 /update {wt=javabin&version=2} {delete=[10032 (-1426108419725590528)]} 0 0
[junit4:junit4]   2> 13394 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[44 (1426108419690987520)]} 0 35
[junit4:junit4]   2> 13395 T1152 C101 P53339 /update {wt=javabin&version=2} {delete=[10032 (-1426108419728736256)]} 0 0
[junit4:junit4]   2> 13396 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[45 (1426108419729784832)]} 0 0
[junit4:junit4]   2> 13398 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[10049 (1426108419731881984)]} 0 0
[junit4:junit4]   2> 13400 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[45 (1426108419733979136)]} 0 0
[junit4:junit4]   2> 13403 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10049 (1426108419736076288)]} 0 1
[junit4:junit4]   2> 13403 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[46 (1426108419737124864)]} 0 0
[junit4:junit4]   2> 13405 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10050 (1426108419739222016)]} 0 0
[junit4:junit4]   2> 13405 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[46 (1426108419739222016)]} 0 0
[junit4:junit4]   2> 13410 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10050 (1426108419744464896)]} 0 0
[junit4:junit4]   2> 13410 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[47 (1426108419744464896)]} 0 0
[junit4:junit4]   2> 13412 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[10051 (1426108419746562048)]} 0 0
[junit4:junit4]   2> 13413 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[47 (1426108419747610624)]} 0 0
[junit4:junit4]   2> 13414 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[10051 (1426108419748659200)]} 0 0
[junit4:junit4]   2> 13419 T1131 C100 P53327 /update {wt=javabin&version=2} {delete=[10033 (-1426108419753902080)]} 0 0
[junit4:junit4]   2> 13419 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[48 (1426108419753902081)]} 0 0
[junit4:junit4]   2> 13425 T1153 C101 P53339 /update {wt=javabin&version=2} {delete=[10033 (-1426108419760193537)]} 0 0
[junit4:junit4]   2> 13425 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[48 (1426108419760193536)]} 0 0
[junit4:junit4]   2> 13430 T1135 C100 P53327 /update {wt=javabin&version=2} {delete=[32 (-1426108419765436417)]} 0 0
[junit4:junit4]   2> 13432 T1154 C101 P53339 /update {wt=javabin&version=2} {delete=[32 (-1426108419767533568)]} 0 0
[junit4:junit4]   2> 13432 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[10052 (1426108419765436416)]} 0 2
[junit4:junit4]   2> 13442 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[49 (1426108419769630720)]} 0 8
[junit4:junit4]   2> 13444 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10052 (1426108419769630720)]} 0 10
[junit4:junit4]   2> 13447 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[49 (1426108419782213632)]} 0 1
[junit4:junit4]   2> 13448 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[10053 (1426108419783262208)]} 0 1
[junit4:junit4]   2> 13449 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[50 (1426108419785359360)]} 0 0
[junit4:junit4]   2> 13450 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10053 (1426108419786407936)]} 0 0
[junit4:junit4]   2> 13452 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[50 (1426108419788505088)]} 0 0
[junit4:junit4]   2> 13454 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[10054 (1426108419790602240)]} 0 0
[junit4:junit4]   2> 13456 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[51 (1426108419792699392)]} 0 0
[junit4:junit4]   2> 13457 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10054 (1426108419793747968)]} 0 0
[junit4:junit4]   2> 13459 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[51 (1426108419795845120)]} 0 0
[junit4:junit4]   2> 13460 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[10055 (1426108419796893696)]} 0 0
[junit4:junit4]   2> 13462 T1133 C100 P53327 /update {wt=javabin&version=2} {delete=[33 (-1426108419798990848)]} 0 0
[junit4:junit4]   2> 13463 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[10055 (1426108419800039424)]} 0 0
[junit4:junit4]   2> 13465 T1151 C101 P53339 /update {wt=javabin&version=2} {delete=[33 (-1426108419802136576)]} 0 0
[junit4:junit4]   2> 13465 T1136 C100 P53327 /update {wt=javabin&version=2} {delete=[10035 (-1426108419802136576)]} 0 0
[junit4:junit4]   2> 13467 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[52 (1426108419804233728)]} 0 0
[junit4:junit4]   2> 13468 T1153 C101 P53339 /update {wt=javabin&version=2} {delete=[10035 (-1426108419805282304)]} 0 0
[junit4:junit4]   2> 13470 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[10056 (1426108419807379456)]} 0 0
[junit4:junit4]   2> 13470 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[52 (1426108419807379456)]} 0 0
[junit4:junit4]   2> 13473 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10056 (1426108419810525184)]} 0 0
[junit4:junit4]   2> 13473 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[53 (1426108419810525184)]} 0 0
[junit4:junit4]   2> 13477 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[53 (1426108419814719488)]} 0 0
[junit4:junit4]   2> 13479 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[10057 (1426108419814719488)]} 0 2
[junit4:junit4]   2> 13481 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[54 (1426108419817865216)]} 0 1
[junit4:junit4]   2> 13484 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[54 (1426108419821010944)]} 0 1
[junit4:junit4]   2> 13486 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10057 (1426108419819962368)]} 0 4
[junit4:junit4]   2> 13488 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[55 (1426108419825205248)]} 0 1
[junit4:junit4]   2> 13489 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[10058 (1426108419827302400)]} 0 0
[junit4:junit4]   2> 13491 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[55 (1426108419829399552)]} 0 0
[junit4:junit4]   2> 13493 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10058 (1426108419830448128)]} 0 1
[junit4:junit4]   2> 13493 T1134 C100 P53327 /update {wt=javabin&version=2} {delete=[35 (-1426108419831496704)]} 0 0
[junit4:junit4]   2> 13494 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10059 (1426108419832545280)]} 0 0
[junit4:junit4]   2> 13497 T1155 C101 P53339 /update {wt=javabin&version=2} {delete=[35 (-1426108419835691008)]} 0 0
[junit4:junit4]   2> 13497 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[10059 (1426108419835691009)]} 0 0
[junit4:junit4]   2> 13499 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[56 (1426108419837788160)]} 0 0
[junit4:junit4]   2> 13500 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[10060 (1426108419838836736)]} 0 0
[junit4:junit4]   2> 13503 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[56 (1426108419841982464)]} 0 0
[junit4:junit4]   2> 13504 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10060 (1426108419841982465)]} 0 1
[junit4:junit4]   2> 13506 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[10061 (1426108419845128192)]} 0 0
[junit4:junit4]   2> 13506 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[57 (1426108419845128193)]} 0 0
[junit4:junit4]   2> 13509 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[57 (1426108419848273921)]} 0 0
[junit4:junit4]   2> 13509 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10061 (1426108419848273920)]} 0 0
[junit4:junit4]   2> 13513 T1135 C100 P53327 /update {wt=javabin&version=2} {delete=[10039 (-1426108419852468225)]} 0 0
[junit4:junit4]   2> 13513 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[58 (1426108419852468224)]} 0 0
[junit4:junit4]   2> 13515 T1153 C101 P53339 /update {wt=javabin&version=2} {delete=[10039 (-1426108419854565376)]} 0 0
[junit4:junit4]   2> 13516 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[58 (1426108419855613952)]} 0 0
[junit4:junit4]   2> 13519 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[59 (1426108419858759680)]} 0 0
[junit4:junit4]   2> 13529 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[10062 (1426108419857711104)]} 0 11
[junit4:junit4]   2> 13531 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[10062 (1426108419871342592)]} 0 0
[junit4:junit4]   2> 13532 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[59 (1426108419870294016)]} 0 2
[junit4:junit4]   2> 13534 T1136 C100 P53327 /update {wt=javabin&version=2} {delete=[10041 (-1426108419874488320)]} 0 0
[junit4:junit4]   2> 13536 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[60 (1426108419875536896)]} 0 1
[junit4:junit4]   2> 13537 T1152 C101 P53339 /update {wt=javabin&version=2} {delete=[10041 (-1426108419877634048)]} 0 0
[junit4:junit4]   2> 13539 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10063 (1426108419879731200)]} 0 0
[junit4:junit4]   2> 13539 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[60 (1426108419879731200)]} 0 0
[junit4:junit4]   2> 13542 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[61 (1426108419882876928)]} 0 0
[junit4:junit4]   2> 13542 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10063 (1426108419882876928)]} 0 0
[junit4:junit4]   2> 13545 T1133 C100 P53327 /update {wt=javabin&version=2} {delete=[10043 (-1426108419886022656)]} 0 0
[junit4:junit4]   2> 13546 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[61 (1426108419886022656)]} 0 1
[junit4:junit4]   2> 13547 T1154 C101 P53339 /update {wt=javabin&version=2} {delete=[10043 (-1426108419888119808)]} 0 0
[junit4:junit4]   2> 13548 T1132 C100 P53327 /update {wt=javabin&version=2} {delete=[39 (-1426108419889168384)]} 0 0
[junit4:junit4]   2> 13550 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[10064 (1426108419891265536)]} 0 0
[junit4:junit4]   2> 13551 T1152 C101 P53339 /update {wt=javabin&version=2} {delete=[39 (-1426108419892314112)]} 0 0
[junit4:junit4]   2> 13552 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10064 (1426108419893362688)]} 0 0
[junit4:junit4]   2> 13552 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[62 (1426108419893362688)]} 0 0
[junit4:junit4]   2> 13555 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10065 (1426108419896508416)]} 0 0
[junit4:junit4]   2> 13556 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[62 (1426108419896508416)]} 0 1
[junit4:junit4]   2> 13558 T1134 C100 P53327 /update {wt=javabin&version=2} {delete=[41 (-1426108419899654144)]} 0 0
[junit4:junit4]   2> 13558 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[10065 (1426108419899654144)]} 0 0
[junit4:junit4]   2> 13561 T1154 C101 P53339 /update {wt=javabin&version=2} {delete=[41 (-1426108419902799872)]} 0 0
[junit4:junit4]   2> 13562 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10066 (1426108419903848448)]} 0 0
[junit4:junit4]   2> 13565 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[63 (1426108419905945600)]} 0 1
[junit4:junit4]   2> 13566 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10066 (1426108419906994176)]} 0 1
[junit4:junit4]   2> 13568 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[63 (1426108419910139904)]} 0 0
[junit4:junit4]   2> 13569 T1136 C100 P53327 /update {wt=javabin&version=2} {delete=[10044 (-1426108419911188480)]} 0 0
[junit4:junit4]   2> 13571 T1151 C101 P53339 /update {wt=javabin&version=2} {delete=[10044 (-1426108419913285632)]} 0 0
[junit4:junit4]   2> 13571 T1131 C100 P53327 /update {wt=javabin&version=2} {delete=[43 (-1426108419913285632)]} 0 0
[junit4:junit4]   2> 13574 T1155 C101 P53339 /update {wt=javabin&version=2} {delete=[43 (-1426108419916431360)]} 0 0
[junit4:junit4]   2> 13577 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10067 (1426108419916431360)]} 0 3
[junit4:junit4]   2> 13577 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[64 (1426108419918528512)]} 0 1
[junit4:junit4]   2> 13580 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[64 (1426108419921674241)]} 0 1
[junit4:junit4]   2> 13580 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10067 (1426108419921674240)]} 0 1
[junit4:junit4]   2> 13581 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[65 (1426108419923771392)]} 0 0
[junit4:junit4]   2> 13583 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[10068 (1426108419925868544)]} 0 0
[junit4:junit4]   2> 13584 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[65 (1426108419926917120)]} 0 0
[junit4:junit4]   2> 13586 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10068 (1426108419929014272)]} 0 0
[junit4:junit4]   2> 13587 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[66 (1426108419930062848)]} 0 0
[junit4:junit4]   2> 13589 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[10069 (1426108419932160000)]} 0 0
[junit4:junit4]   2> 13590 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[66 (1426108419933208576)]} 0 0
[junit4:junit4]   2> 13592 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10069 (1426108419935305728)]} 0 0
[junit4:junit4]   2> 13593 T1134 C100 P53327 /update {wt=javabin&version=2} {delete=[44 (-1426108419936354304)]} 0 0
[junit4:junit4]   2> 13596 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10070 (1426108419938451456)]} 0 1
[junit4:junit4]   2> 13596 T1154 C101 P53339 /update {wt=javabin&version=2} {delete=[44 (-1426108419939500032)]} 0 0
[junit4:junit4]   2> 13598 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10070 (1426108419941597184)]} 0 0
[junit4:junit4]   2> 13599 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[67 (1426108419941597184)]} 0 0
[junit4:junit4]   2> 13602 T1132 C100 P53327 /update {wt=javabin&version=2} {delete=[10047 (-1426108419945791488)]} 0 0
[junit4:junit4]   2> 13603 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[67 (1426108419945791488)]} 0 1
[junit4:junit4]   2> 13604 T1155 C101 P53339 /update {wt=javabin&version=2} {delete=[10047 (-1426108419947888640)]} 0 0
[junit4:junit4]   2> 13606 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[68 (1426108419948937216)]} 0 1
[junit4:junit4]   2> 13608 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[10071 (1426108419951034368)]} 0 1
[junit4:junit4]   2> 13608 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[68 (1426108419952082944)]} 0 0
[junit4:junit4]   2> 13609 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10071 (1426108419953131520)]} 0 0
[junit4:junit4]   2> 13621 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[69 (1426108419954180096)]} 0 11
[junit4:junit4]   2> 13621 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10072 (1426108419956277248)]} 0 9
[junit4:junit4]   2> 13625 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[69 (1426108419968860161)]} 0 1
[junit4:junit4]   2> 13627 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10072 (1426108419968860160)]} 0 3
[junit4:junit4]   2> 13628 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[70 (1426108419973054464)]} 0 0
[junit4:junit4]   2> 13629 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[10073 (1426108419974103040)]} 0 0
[junit4:junit4]   2> 13631 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[70 (1426108419976200192)]} 0 0
[junit4:junit4]   2> 13633 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10073 (1426108419978297344)]} 0 0
[junit4:junit4]   2> 13635 T1136 C100 P53327 /update {wt=javabin&version=2} {delete=[47 (-1426108419980394496)]} 0 0
[junit4:junit4]   2> 13636 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10074 (1426108419981443072)]} 0 0
[junit4:junit4]   2> 13638 T1153 C101 P53339 /update {wt=javabin&version=2} {delete=[47 (-1426108419983540224)]} 0 0
[junit4:junit4]   2> 13638 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10074 (1426108419983540225)]} 0 0
[junit4:junit4]   2> 13641 T1133 C100 P53327 /update {wt=javabin&version=2} {delete=[10050 (-1426108419986685953)]} 0 0
[junit4:junit4]   2> 13641 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[71 (1426108419986685952)]} 0 0
[junit4:junit4]   2> 13643 T1155 C101 P53339 /update {wt=javabin&version=2} {delete=[10050 (-1426108419988783104)]} 0 0
[junit4:junit4]   2> 13644 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[71 (1426108419989831680)]} 0 0
[junit4:junit4]   2> 13646 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[10075 (1426108419991928832)]} 0 0
[junit4:junit4]   2> 13647 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[72 (1426108419992977408)]} 0 0
[junit4:junit4]   2> 13649 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10075 (1426108419995074560)]} 0 0
[junit4:junit4]   2> 13650 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[72 (1426108419996123136)]} 0 0
[junit4:junit4]   2> 13652 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[10076 (1426108419998220288)]} 0 0
[junit4:junit4]   2> 13653 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[73 (1426108419999268864)]} 0 0
[junit4:junit4]   2> 13658 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[73 (1426108420004511745)]} 0 0
[junit4:junit4]   2> 13658 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10076 (1426108420004511744)]} 0 0
[junit4:junit4]   2> 13662 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[10077 (1426108420007657473)]} 0 1
[junit4:junit4]   2> 13665 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[74 (1426108420007657472)]} 0 4
[junit4:junit4]   2> 13668 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[74 (1426108420013948928)]} 0 1
[junit4:junit4]   2> 13673 T1131 C100 P53327 /update {wt=javabin&version=2} {delete=[50 (-1426108420020240384)]} 0 0
[junit4:junit4]   2> 13678 T1153 C101 P53339 /update {wt=javabin&version=2} {delete=[50 (-1426108420025483264)]} 0 0
[junit4:junit4]   2> 13688 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10077 (1426108420012900352)]} 0 22
[junit4:junit4]   2> 13690 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[75 (1426108420037017600)]} 0 1
[junit4:junit4]   2> 13691 T1135 C100 P53327 /update {wt=javabin&version=2} {delete=[10054 (-1426108420039114752)]} 0 0
[junit4:junit4]   2> 13692 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[75 (1426108420040163328)]} 0 0
[junit4:junit4]   2> 13694 T1155 C101 P53339 /update {wt=javabin&version=2} {delete=[10054 (-1426108420042260480)]} 0 0
[junit4:junit4]   2> 13695 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[76 (1426108420043309056)]} 0 0
[junit4:junit4]   2> 13697 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[10078 (1426108420045406208)]} 0 0
[junit4:junit4]   2> 13697 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[76 (1426108420045406208)]} 0 0
[junit4:junit4]   2> 13699 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10078 (1426108420047503360)]} 0 0
[junit4:junit4]   2> 13701 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[77 (1426108420049600512)]} 0 0
[junit4:junit4]   2> 13703 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[10079 (1426108420051697664)]} 0 0
[junit4:junit4]   2> 13703 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[77 (1426108420051697664)]} 0 0
[junit4:junit4]   2> 13706 T1132 C100 P53327 /update {wt=javabin&version=2} {delete=[54 (-1426108420054843392)]} 0 0
[junit4:junit4]   2> 13706 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10079 (1426108420054843392)]} 0 0
[junit4:junit4]   2> 13708 T1155 C101 P53339 /update {wt=javabin&version=2} {delete=[54 (-1426108420056940544)]} 0 0
[junit4:junit4]   2> 13709 T1135 C100 P53327 /update {wt=javabin&version=2} {delete=[10055 (-1426108420057989120)]} 0 0
[junit4:junit4]   2> 13711 T1152 C101 P53339 /update {wt=javabin&version=2} {delete=[10055 (-1426108420060086272)]} 0 0
[junit4:junit4]   2> 13711 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[78 (1426108420060086272)]} 0 0
[junit4:junit4]   2> 13713 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[10080 (1426108420062183424)]} 0 0
[junit4:junit4]   2> 13714 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[78 (1426108420063232000)]} 0 0
[junit4:junit4]   2> 13716 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10080 (1426108420065329152)]} 0 0
[junit4:junit4]   2> 13717 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[79 (1426108420066377728)]} 0 0
[junit4:junit4]   2> 13720 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[79 (1426108420069523456)]} 0 0
[junit4:junit4]   2> 13723 T1132 C100 P53327 /update {wt=javabin&version=2} {delete=[55 (-1426108420072669184)]} 0 0
[junit4:junit4]   2> 13725 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[10081 (1426108420068474880)]} 0 6
[junit4:junit4]   2> 13726 T1155 C101 P53339 /update {wt=javabin&version=2} {delete=[55 (-1426108420075814912)]} 0 0
[junit4:junit4]   2> 13736 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[80 (1426108420085252096)]} 0 1
[junit4:junit4]   2> 13739 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[80 (1426108420088397824)]} 0 1
[junit4:junit4]   2> 13740 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10081 (1426108420085252096)]} 0 5
[junit4:junit4]   2> 13742 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[81 (1426108420092592128)]} 0 0
[junit4:junit4]   2> 13743 T1136 C100 P53327 /update {wt=javabin&version=2} {delete=[10060 (-1426108420093640704)]} 0 0
[junit4:junit4]   2> 13746 T1151 C101 P53339 /update {wt=javabin&version=2} {delete=[10060 (-1426108420096786433)]} 0 0
[junit4:junit4]   2> 13746 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[81 (1426108420096786432)]} 0 0
[junit4:junit4]   2> 13748 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10082 (1426108420098883584)]} 0 0
[junit4:junit4]   2> 13749 T1132 C100 P53327 /update {wt=javabin&version=2} {delete=[60 (-1426108420099932160)]} 0 0
[junit4:junit4]   2> 13751 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[10082 (1426108420102029312)]} 0 0
[junit4:junit4]   2> 13752 T1153 C101 P53339 /update {wt=javabin&version=2} {delete=[60 (-1426108420103077888)]} 0 0
[junit4:junit4]   2> 13755 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[10083 (1426108420105175040)]} 0 1
[junit4:junit4]   2> 13755 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[82 (1426108420106223616)]} 0 0
[junit4:junit4]   2> 13759 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[82 (1426108420109369344)]} 0 1
[junit4:junit4]   2> 13759 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10083 (1426108420110417920)]} 0 0
[junit4:junit4]   2> 13763 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[83 (1426108420113563648)]} 0 1
[junit4:junit4]   2> 13764 T1136 C100 P53327 /update {wt=javabin&version=2} {delete=[10061 (-1426108420115660800)]} 0 0
[junit4:junit4]   2> 13765 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[83 (1426108420116709376)]} 0 0
[junit4:junit4]   2> 13767 T1155 C101 P53339 /update {wt=javabin&version=2} {delete=[10061 (-1426108420118806528)]} 0 0
[junit4:junit4]   2> 13769 T1132 C100 P53327 /update {wt=javabin&version=2} {delete=[61 (-1426108420120903681)]} 0 0
[junit4:junit4]   2> 13769 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10084 (1426108420120903680)]} 0 0
[junit4:junit4]   2> 13771 T1153 C101 P53339 /update {wt=javabin&version=2} {delete=[61 (-1426108420123000832)]} 0 0
[junit4:junit4]   2> 13772 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10084 (1426108420124049408)]} 0 0
[junit4:junit4]   2> 13773 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[84 (1426108420125097984)]} 0 0
[junit4:junit4]   2> 13775 T1135 C100 P53327 /update {wt=javabin&version=2} {delete=[10064 (-1426108420127195136)]} 0 0
[junit4:junit4]   2> 13776 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[84 (1426108420128243712)]} 0 0
[junit4:junit4]   2> 13778 T1154 C101 P53339 /update {wt=javabin&version=2} {delete=[10064 (-1426108420130340864)]} 0 0
[junit4:junit4]   2> 13779 T1134 C100 P53327 /update {wt=javabin&version=2} {delete=[64 (-1426108420131389440)]} 0 0
[junit4:junit4]   2> 13781 T1155 C101 P53339 /update {wt=javabin&version=2} {delete=[64 (-1426108420133486592)]} 0 0
[junit4:junit4]   2> 13781 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[10085 (1426108420133486592)]} 0 0
[junit4:junit4]   2> 13785 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10085 (1426108420137680896)]} 0 0
[junit4:junit4]   2> 13787 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[85 (1426108420137680896)]} 0 2
[junit4:junit4]   2> 13787 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10086 (1426108420139778048)]} 0 0
[junit4:junit4]   2> 13802 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[85 (1426108420141875200)]} 0 13
[junit4:junit4]   2> 13802 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10086 (1426108420142923776)]} 0 12
[junit4:junit4]   2> 13806 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[86 (1426108420159700993)]} 0 0
[junit4:junit4]   2> 13807 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10087 (1426108420159700992)]} 0 1
[junit4:junit4]   2> 13809 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[86 (1426108420162846720)]} 0 0
[junit4:junit4]   2> 13810 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[10087 (1426108420162846721)]} 0 1
[junit4:junit4]   2> 13812 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[10088 (1426108420165992449)]} 0 0
[junit4:junit4]   2> 13812 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[87 (1426108420165992448)]} 0 0
[junit4:junit4]   2> 13814 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10088 (1426108420168089600)]} 0 0
[junit4:junit4]   2> 13814 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[87 (1426108420168089601)]} 0 0
[junit4:junit4]   2> 13818 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[88 (1426108420172283904)]} 0 0
[junit4:junit4]   2> 13818 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10089 (1426108420172283905)]} 0 0
[junit4:junit4]   2> 13821 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10089 (1426108420175429632)]} 0 0
[junit4:junit4]   2> 13822 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[88 (1426108420175429633)]} 0 1
[junit4:junit4]   2> 13824 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[10090 (1426108420178575360)]} 0 0
[junit4:junit4]   2> 13824 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[89 (1426108420178575361)]} 0 0
[junit4:junit4]   2> 13827 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[89 (1426108420181721088)]} 0 0
[junit4:junit4]   2> 13828 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[10090 (1426108420181721089)]} 0 1
[junit4:junit4]   2> 13830 T1134 C100 P53327 /update {wt=javabin&version=2} {delete=[10068 (-1426108420184866816)]} 0 0
[junit4:junit4]   2> 13832 T1151 C101 P53339 /update {wt=javabin&version=2} {delete=[10068 (-1426108420186963968)]} 0 0
[junit4:junit4]   2> 13832 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[90 (1426108420184866817)]} 0 2
[junit4:junit4]   2> 13834 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[10091 (1426108420189061120)]} 0 0
[junit4:junit4]   2> 13837 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10091 (1426108420192206848)]} 0 0
[junit4:junit4]   2> 13838 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[90 (1426108420191158272)]} 0 2
[junit4:junit4]   2> 13840 T1133 C100 P53327 /update {wt=javabin&version=2} {delete=[10074 (-1426108420195352576)]} 0 0
[junit4:junit4]   2> 13841 T1131 C100 P53327 /update {wt=javabin&version=2} {delete=[68 (-1426108420196401152)]} 0 0
[junit4:junit4]   2> 13842 T1155 C101 P53339 /update {wt=javabin&version=2} {delete=[10074 (-1426108420197449728)]} 0 0
[junit4:junit4]   2> 13843 T1153 C101 P53339 /update {wt=javabin&version=2} {delete=[68 (-1426108420198498304)]} 0 0
[junit4:junit4]   2> 13846 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10092 (1426108420199546880)]} 0 2
[junit4:junit4]   2> 13847 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[91 (1426108420201644032)]} 0 1
[junit4:junit4]   2> 13848 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10092 (1426108420203741184)]} 0 0
[junit4:junit4]   2> 13850 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[91 (1426108420205838336)]} 0 0
[junit4:junit4]   2> 13851 T1136 C100 P53327 /update {wt=javabin&version=2} {delete=[10076 (-1426108420206886912)]} 0 0
[junit4:junit4]   2> 13854 T1132 C100 P53327 /update {wt=javabin&version=2} {delete=[74 (-1426108420210032640)]} 0 0
[junit4:junit4]   2> 13854 T1154 C101 P53339 /update {wt=javabin&version=2} {delete=[10076 (-1426108420210032640)]} 0 0
[junit4:junit4]   2> 13857 T1155 C101 P53339 /update {wt=javabin&version=2} {delete=[74 (-1426108420213178368)]} 0 0
[junit4:junit4]   2> 13857 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10093 (1426108420213178368)]} 0 0
[junit4:junit4]   2> 13859 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[92 (1426108420215275520)]} 0 0
[junit4:junit4]   2> 13860 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10093 (1426108420216324096)]} 0 0
[junit4:junit4]   2> 13862 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[92 (1426108420218421248)]} 0 0
[junit4:junit4]   2> 13863 T1135 C100 P53327 /update {wt=javabin&version=2} {delete=[10078 (-1426108420219469824)]} 0 0
[junit4:junit4]   2> 13865 T1152 C101 P53339 /update {wt=javabin&version=2} {delete=[10078 (-1426108420221566976)]} 0 0
[junit4:junit4]   2> 13865 T1134 C100 P53327 /update {wt=javabin&version=2} {delete=[76 (-1426108420221566976)]} 0 0
[junit4:junit4]   2> 13867 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[10094 (1426108420223664128)]} 0 0
[junit4:junit4]   2> 13868 T1154 C101 P53339 /update {wt=javabin&version=2} {delete=[76 (-1426108420224712704)]} 0 0
[junit4:junit4]   2> 13870 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[10094 (1426108420226809856)]} 0 0
[junit4:junit4]   2> 13870 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[93 (1426108420226809856)]} 0 0
[junit4:junit4]   2> 13872 T1133 C100 P53327 /update {wt=javabin&version=2} {delete=[10079 (-1426108420228907008)]} 0 0
[junit4:junit4]   2> 13872 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[93 (1426108420228907008)]} 0 0
[junit4:junit4]   2> 13874 T1151 C101 P53339 /update {wt=javabin&version=2} {delete=[10079 (-1426108420231004160)]} 0 0
[junit4:junit4]   2> 13876 T1131 C100 P53327 /update {wt=javabin&version=2} {delete=[78 (-1426108420233101312)]} 0 0
[junit4:junit4]   2> 13876 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10095 (1426108420233101313)]} 0 0
[junit4:junit4]   2> 13878 T1152 C101 P53339 /update {wt=javabin&version=2} {delete=[78 (-1426108420235198464)]} 0 0
[junit4:junit4]   2> 13879 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10095 (1426108420236247040)]} 0 0
[junit4:junit4]   2> 13881 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[94 (1426108420238344192)]} 0 0
[junit4:junit4]   2> 13882 T1136 C100 P53327 /update {wt=javabin&version=2} {delete=[10080 (-1426108420239392768)]} 0 0
[junit4:junit4]   2> 13884 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[94 (1426108420241489920)]} 0 0
[junit4:junit4]   2> 13885 T1153 C101 P53339 /update {wt=javabin&version=2} {delete=[10080 (-1426108420242538496)]} 0 0
[junit4:junit4]   2> 13887 T1132 C100 P53327 /update {wt=javabin&version=2} {delete=[79 (-1426108420244635648)]} 0 0
[junit4:junit4]   2> 13890 T1151 C101 P53339 /update {wt=javabin&version=2} {delete=[79 (-1426108420247781376)]} 0 0
[junit4:junit4]   2> 13891 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10096 (1426108420245684224)]} 0 3
[junit4:junit4]   2> 13893 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[95 (1426108420250927104)]} 0 0
[junit4:junit4]   2> 13902 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[95 (1426108420260364288)]} 0 1
[junit4:junit4]   2> 13902 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10096 (1426108420250927104)]} 0 9
[junit4:junit4]   2> 13906 T1134 C100 P53327 /update {wt=javabin&version=2} {delete=[80 (-1426108420264558593)]} 0 0
[junit4:junit4]   2> 13906 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10097 (1426108420264558592)]} 0 0
[junit4:junit4]   2> 13909 T1153 C101 P53339 /update {wt=javabin&version=2} {delete=[80 (-1426108420267704320)]} 0 0
[junit4:junit4]   2> 13909 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[10097 (1426108420267704321)]} 0 0
[junit4:junit4]   2> 13911 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[96 (1426108420269801472)]} 0 0
[junit4:junit4]   2> 13912 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[10098 (1426108420270850048)]} 0 0
[junit4:junit4]   2> 13915 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[96 (1426108420272947200)]} 0 1
[junit4:junit4]   2> 13916 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10098 (1426108420273995776)]} 0 1
[junit4:junit4]   2> 13917 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[97 (1426108420276092928)]} 0 0
[junit4:junit4]   2> 13918 T1131 C100 P53327 /update {wt=javabin&version=2} {delete=[10082 (-1426108420277141504)]} 0 0
[junit4:junit4]   2> 13920 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[97 (1426108420279238656)]} 0 0
[junit4:junit4]   2> 13922 T1153 C101 P53339 /update {wt=javabin&version=2} {delete=[10082 (-1426108420281335808)]} 0 0
[junit4:junit4]   2> 13924 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[98 (1426108420283432960)]} 0 0
[junit4:junit4]   2> 13925 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10099 (1426108420283432961)]} 0 1
[junit4:junit4]   2> 13927 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[10099 (1426108420286578688)]} 0 0
[junit4:junit4]   2> 13928 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[98 (1426108420286578689)]} 0 1
[junit4:junit4]   2> 13929 T1132 C100 P53327 /update {wt=javabin&version=2} {delete=[82 (-1426108420288675840)]} 0 0
[junit4:junit4]   2> 13929 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[10100 (1426108420288675841)]} 0 0
[junit4:junit4]   2> 13931 T1154 C101 P53339 /update {wt=javabin&version=2} {delete=[82 (-1426108420290772992)]} 0 0
[junit4:junit4]   2> 13940 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10100 (1426108420299161600)]} 0 1
[junit4:junit4]   2> 13940 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[99 (1426108420300210176)]} 0 0
[junit4:junit4]   2> 13942 T1131 C100 P53327 /update {wt=javabin&version=2} {delete=[10084 (-1426108420302307328)]} 0 0
[junit4:junit4]   2> 13944 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[99 (1426108420304404480)]} 0 0
[junit4:junit4]   2> 13945 T1155 C101 P53339 /update {wt=javabin&version=2} {delete=[10084 (-1426108420305453056)]} 0 0
[junit4:junit4]   2> 13948 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[100 (1426108420307550209)]} 0 1
[junit4:junit4]   2> 13949 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[10101 (1426108420307550208)]} 0 2
[junit4:junit4]   2> 13953 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[100 (1426108420310695936)]} 0 3
[junit4:junit4]   2> 13953 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10101 (1426108420312793088)]} 0 1
[junit4:junit4]   2> 13955 T1136 C100 P53327 /update {wt=javabin&version=2} {delete=[84 (-1426108420315938816)]} 0 0
[junit4:junit4]   2> 13955 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[10102 (1426108420315938817)]} 0 0
[junit4:junit4]   2> 13957 T1152 C101 P53339 /update {wt=javabin&version=2} {delete=[84 (-1426108420318035968)]} 0 0
[junit4:junit4]   2> 13958 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10102 (1426108420319084544)]} 0 0
[junit4:junit4]   2> 13960 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[101 (1426108420321181696)]} 0 0
[junit4:junit4]   2> 13960 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[10103 (1426108420321181697)]} 0 0
[junit4:junit4]   2> 13963 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[10103 (1426108420324327424)]} 0 0
[junit4:junit4]   2> 13964 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[101 (1426108420324327425)]} 0 1
[junit4:junit4]   2> 13966 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10104 (1426108420327473152)]} 0 0
[junit4:junit4]   2> 13967 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[102 (1426108420327473153)]} 0 1
[junit4:junit4]   2> 13969 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10104 (1426108420330618880)]} 0 0
[junit4:junit4]   2> 13969 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[102 (1426108420330618881)]} 0 0
[junit4:junit4]   2> 13972 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[103 (1426108420333764608)]} 0 0
[junit4:junit4]   2> 13972 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[10105 (1426108420333764609)]} 0 0
[junit4:junit4]   2> 13975 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10105 (1426108420336910336)]} 0 0
[junit4:junit4]   2> 13976 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[103 (1426108420336910337)]} 0 1
[junit4:junit4]   2> 13978 T1133 C100 P53327 /update {wt=javabin&version=2} {delete=[10087 (-1426108420340056064)]} 0 0
[junit4:junit4]   2> 13979 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[104 (1426108420341104640)]} 0 0
[junit4:junit4]   2> 13980 T1154 C101 P53339 /update {wt=javabin&version=2} {delete=[10087 (-1426108420342153216)]} 0 0
[junit4:junit4]   2> 13982 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[104 (1426108420344250368)]} 0 0
[junit4:junit4]   2> 13984 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10106 (1426108420344250368)]} 0 2
[junit4:junit4]   2> 13985 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[105 (1426108420347396096)]} 0 0
[junit4:junit4]   2> 13996 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[105 (1426108420356833280)]} 0 2
[junit4:junit4]   2> 13996 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10106 (1426108420349493248)]} 0 9
[junit4:junit4]   2> 13998 T1132 C100 P53327 /update {wt=javabin&version=2} {delete=[87 (-1426108420361027584)]} 0 0
[junit4:junit4]   2> 13999 T1136 C100 P53327 /update {wt=javabin&version=2} {delete=[10088 (-1426108420362076160)]} 0 0
[junit4:junit4]   2> 14001 T1155 C101 P53339 /update {wt=javabin&version=2} {delete=[87 (-1426108420364173312)]} 0 0
[junit4:junit4]   2> 14002 T1154 C101 P53339 /update {wt=javabin&version=2} {delete=[10088 (-1426108420365221888)]} 0 0
[junit4:junit4]   2> 14004 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[106 (1426108420367319040)]} 0 0
[junit4:junit4]   2> 14005 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[10107 (1426108420368367616)]} 0 0
[junit4:junit4]   2> 14007 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[106 (1426108420370464768)]} 0 0
[junit4:junit4]   2> 14008 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10107 (1426108420371513344)]} 0 0
[junit4:junit4]   2> 14010 T1135 C100 P53327 /update {wt=javabin&version=2} {delete=[88 (-1426108420373610496)]} 0 0
[junit4:junit4]   2> 14012 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[10108 (1426108420375707648)]} 0 0
[junit4:junit4]   2> 14014 T1152 C101 P53339 /update {wt=javabin&version=2} {delete=[88 (-1426108420377804800)]} 0 0
[junit4:junit4]   2> 14015 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[10108 (1426108420378853376)]} 0 0
[junit4:junit4]   2> 14017 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[107 (1426108420380950528)]} 0 0
[junit4:junit4]   2> 14017 T1136 C100 P53327 /update {wt=javabin&version=2} {delete=[10089 (-1426108420380950529)]} 0 0
[junit4:junit4]   2> 14020 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[107 (1426108420383047680)]} 0 1
[junit4:junit4]   2> 14020 T1154 C101 P53339 /update {wt=javabin&version=2} {delete=[10089 (-1426108420384096256)]} 0 0
[junit4:junit4]   2> 14022 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[108 (1426108420386193408)]} 0 0
[junit4:junit4]   2> 14023 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10109 (1426108420387241984)]} 0 0
[junit4:junit4]   2> 14025 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[108 (1426108420389339136)]} 0 0
[junit4:junit4]   2> 14026 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10109 (1426108420390387712)]} 0 0
[junit4:junit4]   2> 14028 T1135 C100 P53327 /update {wt=javabin&version=2} {delete=[89 (-1426108420392484864)]} 0 0
[junit4:junit4]   2> 14029 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[10110 (1426108420393533440)]} 0 0
[junit4:junit4]   2> 14031 T1155 C101 P53339 /update {wt=javabin&version=2} {delete=[89 (-1426108420395630592)]} 0 0
[junit4:junit4]   2> 14032 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10110 (1426108420396679168)]} 0 0
[junit4:junit4]   2> 14034 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[109 (1426108420398776320)]} 0 0
[junit4:junit4]   2> 14036 T1136 C100 P53327 /update {wt=javabin&version=2} {delete=[10090 (-1426108420400873472)]} 0 0
[junit4:junit4]   2> 14038 T1151 C101 P53339 /update {wt=javabin&version=2} {delete=[10090 (-1426108420402970624)]} 0 0
[junit4:junit4]   2> 14038 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[109 (1426108420402970625)]} 0 0
[junit4:junit4]   2> 14041 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[110 (1426108420406116352)]} 0 0
[junit4:junit4]   2> 14043 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[10111 (1426108420405067776)]} 0 3
[junit4:junit4]   2> 14045 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10111 (1426108420410310656)]} 0 0
[junit4:junit4]   2> 14046 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[110 (1426108420409262080)]} 0 2
[junit4:junit4]   2> 14047 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[10112 (1426108420412407808)]} 0 0
[junit4:junit4]   2> 14048 T1132 C100 P53327 /update {wt=javabin&version=2} {delete=[90 (-1426108420413456384)]} 0 0
[junit4:junit4]   2> 14050 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10112 (1426108420415553536)]} 0 0
[junit4:junit4]   2> 14052 T1152 C101 P53339 /update {wt=javabin&version=2} {delete=[90 (-1426108420417650688)]} 0 0
[junit4:junit4]   2> 14055 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[10113 (1426108420419747840)]} 0 1
[junit4:junit4]   2> 14055 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[111 (1426108420419747841)]} 0 1
[junit4:junit4]   2> 14057 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10113 (1426108420422893568)]} 0 0
[junit4:junit4]   2> 14057 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[111 (1426108420422893569)]} 0 0
[junit4:junit4]   2> 14060 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10114 (1426108420426039296)]} 0 0
[junit4:junit4]   2> 14061 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[112 (1426108420426039297)]} 0 1
[junit4:junit4]   2> 14063 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[10114 (1426108420429185024)]} 0 0
[junit4:junit4]   2> 14064 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[112 (1426108420429185025)]} 0 1
[junit4:junit4]   2> 14071 T1134 C100 P53327 /update {wt=javabin&version=2} {delete=[10091 (-1426108420437573632)]} 0 0
[junit4:junit4]   2> 14073 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[113 (1426108420439670784)]} 0 0
[junit4:junit4]   2> 14074 T1152 C101 P53339 /update {wt=javabin&version=2} {delete=[10091 (-1426108420440719360)]} 0 0
[junit4:junit4]   2> 14075 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[113 (1426108420441767936)]} 0 0
[junit4:junit4]   2> 14076 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10115 (1426108420442816512)]} 0 0
[junit4:junit4]   2> 14079 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[114 (1426108420445962240)]} 0 0
[junit4:junit4]   2> 14079 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10115 (1426108420445962240)]} 0 0
[junit4:junit4]   2> 14082 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[114 (1426108420449107968)]} 0 0
[junit4:junit4]   2> 14085 T1135 C100 P53327 /update {wt=javabin&version=2} {delete=[91 (-1426108420452253696)]} 0 0
[junit4:junit4]   2> 14088 T1151 C101 P53339 /update {wt=javabin&version=2} {delete=[91 (-1426108420455399424)]} 0 0
[junit4:junit4]   2> 14094 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[115 (1426108420458545152)]} 0 3
[junit4:junit4]   2> 14104 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[115 (1426108420464836608)]} 0 7
[junit4:junit4]   2> 14108 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[116 (1426108420476370944)]} 0 0
[junit4:junit4]   2> 14112 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[116 (1426108420479516672)]} 0 1
[junit4:junit4]   2> 14153 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[10116 (1426108420449107968)]} 0 71
[junit4:junit4]   2> 14154 T1133 C100 P53327 /update {wt=javabin&version=2} {delete=[92 (-1426108420524605440)]} 0 30
[junit4:junit4]   2> 14156 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10116 (1426108420526702592)]} 0 0
[junit4:junit4]   2> 14157 T1154 C101 P53339 /update {wt=javabin&version=2} {delete=[92 (-1426108420527751168)]} 0 0
[junit4:junit4]   2> 14159 T1136 C100 P53327 /update {wt=javabin&version=2} {delete=[10092 (-1426108420529848320)]} 0 0
[junit4:junit4]   2> 14160 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[117 (1426108420529848321)]} 0 1
[junit4:junit4]   2> 14162 T1151 C101 P53339 /update {wt=javabin&version=2} {delete=[10092 (-1426108420532994048)]} 0 0
[junit4:junit4]   2> 14162 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[117 (1426108420532994049)]} 0 0
[junit4:junit4]   2> 14164 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[118 (1426108420535091200)]} 0 0
[junit4:junit4]   2> 14165 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[10117 (1426108420536139776)]} 0 0
[junit4:junit4]   2> 14167 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[118 (1426108420538236928)]} 0 0
[junit4:junit4]   2> 14168 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10117 (1426108420539285504)]} 0 0
[junit4:junit4]   2> 14170 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[119 (1426108420541382656)]} 0 0
[junit4:junit4]   2> 14171 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10118 (1426108420542431232)]} 0 0
[junit4:junit4]   2> 14173 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[119 (1426108420544528384)]} 0 0
[junit4:junit4]   2> 14175 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10118 (1426108420546625536)]} 0 0
[junit4:junit4]   2> 14177 T1136 C100 P53327 /update {wt=javabin&version=2} {delete=[95 (-1426108420548722688)]} 0 0
[junit4:junit4]   2> 14178 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[10119 (1426108420549771264)]} 0 0
[junit4:junit4]   2> 14180 T1152 C101 P53339 /update {wt=javabin&version=2} {delete=[95 (-1426108420551868416)]} 0 0
[junit4:junit4]   2> 14181 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10119 (1426108420552916992)]} 0 0
[junit4:junit4]   2> 14183 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[120 (1426108420555014144)]} 0 0
[junit4:junit4]   2> 14184 T1132 C100 P53327 /update {wt=javabin&version=2} {delete=[10095 (-1426108420556062720)]} 0 0
[junit4:junit4]   2> 14186 T1154 C101 P53339 /update {wt=javabin&version=2} {delete=[10095 (-1426108420558159872)]} 0 0
[junit4:junit4]   2> 14187 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[120 (1426108420558159873)]} 0 1
[junit4:junit4]   2> 14190 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[121 (1426108420561305601)]} 0 1
[junit4:junit4]   2> 14210 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[121 (1426108420565499904)]} 0 17
[junit4:junit4]   2> 14214 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[122 (1426108420587520000)]} 0 0
[junit4:junit4]   2> 14217 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[122 (1426108420590665728)]} 0 0
[junit4:junit4]   2> 14220 T1135 C100 P53327 /update {wt=javabin&version=2} {delete=[97 (-1426108420593811456)]} 0 0
[junit4:junit4]   2> 14222 T1153 C101 P53339 /update {wt=javabin&version=2} {delete=[97 (-1426108420595908608)]} 0 0
[junit4:junit4]   2> 14225 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[123 (1426108420599054336)]} 0 0
[junit4:junit4]   2> 14229 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[123 (1426108420603248640)]} 0 0
[junit4:junit4]   2> 14232 T1132 C100 P53327 /update {wt=javabin&version=2} {delete=[100 (-1426108420606394368)]} 0 0
[junit4:junit4]   2> 14235 T1155 C101 P53339 /update {wt=javabin&version=2} {delete=[100 (-1426108420609540096)]} 0 0
[junit4:junit4]   2> 14238 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[124 (1426108420612685824)]} 0 0
[junit4:junit4]   2> 14241 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[124 (1426108420615831552)]} 0 0
[junit4:junit4]   2> 14245 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[125 (1426108420618977280)]} 0 1
[junit4:junit4]   2> 14248 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[125 (1426108420622123008)]} 0 1
[junit4:junit4]   2> 14249 T1141 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 14250 T1141 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "numShards":"1",
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "state":"recovering",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:53348__vua",
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:53348/_vua"}
[junit4:junit4]   2> 14250 T1135 C100 P53327 /update {wt=javabin&version=2} {delete=[102 (-1426108420625268736)]} 0 0
[junit4:junit4]   2> 14253 T1153 C101 P53339 /update {wt=javabin&version=2} {delete=[102 (-1426108420628414464)]} 0 0
[junit4:junit4]   2> 14256 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[126 (1426108420631560192)]} 0 0
[junit4:junit4]   2> 14261 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[126 (1426108420634705920)]} 0 2
[junit4:junit4]   2> 14264 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[127 (1426108420638900224)]} 0 1
[junit4:junit4]   2> 14266 T1174 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4:junit4]   2> 14267 T1146 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4:junit4]   2> 14268 T1140 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4:junit4]   2> 14269 T1159 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4:junit4]   2> 14269 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[127 (1426108420644143104)]} 0 1
[junit4:junit4]   2> 14270 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[10120 (1426108420561305600)]} 0 81
[junit4:junit4]   2> 14273 T1133 C100 P53327 /update {wt=javabin&version=2} {delete=[104 (-1426108420649385984)]} 0 1
[junit4:junit4]   2> 14275 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10120 (1426108420650434560)]} 0 2
[junit4:junit4]   2> 14279 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[10121 (1426108420655677440)]} 0 0
[junit4:junit4]   2>  C99_STATE=coll:collection1 core:collection1 props:{shard=shard1, roles=null, state=recovering, core=collection1, collection=collection1, node_name=127.0.0.1:53348__vua, base_url=http://127.0.0.1:53348/_vua}
[junit4:junit4]   2> 14302 T1170 C99 P53348 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\jetty2
[junit4:junit4]   2> 14308 T1170 C99 P53348 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@62fafb lockFactory=org.apache.lucene.store.NativeFSLockFactory@1eeb0f)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 14308 T1170 C99 P53348 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 14310 T1170 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[104 (-1426108420652531712)]} 0 10
[junit4:junit4]   2> 14311 T1152 C101 P53339 /update {wt=javabin&version=2} {delete=[104 (-1426108420652531712)]} 0 35
[junit4:junit4]   2> 14311 T1165 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10121 (1426108420658823168)]} 0 7
[junit4:junit4]   2> 14313 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[10121 (1426108420658823168)]} 0 31
[junit4:junit4]   2> 14314 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[128 (1426108420692377600)]} 0 0
[junit4:junit4]   2> 14318 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[10122 (1426108420693426176)]} 0 3
[junit4:junit4]   2> 14322 T1166 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[128 (1426108420695523328)]} 0 2
[junit4:junit4]   2> 14323 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[128 (1426108420695523328)]} 0 6
[junit4:junit4]   2> 14344 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[129 (1426108420722786304)]} 0 1
[junit4:junit4]   2> 14349 T1167 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10122 (1426108420700766208)]} 0 1
[junit4:junit4]   2> 14351 T1168 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[129 (1426108420725932032)]} 0 1
[junit4:junit4]   2> 14352 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[10122 (1426108420700766208)]} 0 30
[junit4:junit4]   2> 14353 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[129 (1426108420725932032)]} 0 7
[junit4:junit4]   2> 14355 T1131 C100 P53327 /update {wt=javabin&version=2} {delete=[10097 (-1426108420735369216)]} 0 0
[junit4:junit4]   2> 14357 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[130 (1426108420737466368)]} 0 0
[junit4:junit4]   2> 14362 T1169 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[10097 (-1426108420739563520)]} 0 1
[junit4:junit4]   2> 14364 T1169 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[130 (1426108420740612096)]} 0 1
[junit4:junit4]   2> 14365 T1152 C101 P53339 /update {wt=javabin&version=2} {delete=[10097 (-1426108420739563520)]} 0 6
[junit4:junit4]   2> 14366 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[130 (1426108420740612096)]} 0 6
[junit4:junit4]   2> 14367 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[10123 (1426108420747952128)]} 0 0
[junit4:junit4]   2> 14369 T1135 C100 P53327 /update {wt=javabin&version=2} {add=[131 (1426108420750049280)]} 0 0
[junit4:junit4]   2> 14375 T1170 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10123 (1426108420752146432)]} 0 1
[junit4:junit4]   2> 14376 T1166 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[131 (1426108420753195008)]} 0 0
[junit4:junit4]   2> 14378 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10123 (1426108420752146432)]} 0 7
[junit4:junit4]   2> 14379 T1155 C101 P53339 /update {wt=javabin&version=2} {add=[131 (1426108420753195008)]} 0 7
[junit4:junit4]   2> 14381 T1134 C100 P53327 /update {wt=javabin&version=2} {delete=[10100 (-1426108420762632192)]} 0 0
[junit4:junit4]   2> 14382 T1132 C100 P53327 /update {wt=javabin&version=2} {delete=[107 (-1426108420763680768)]} 0 0
[junit4:junit4]   2> 14389 T1168 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[107 (-1426108420767875072)]} 0 0
[junit4:junit4]   2> 14390 T1152 C101 P53339 /update {wt=javabin&version=2} {delete=[107 (-1426108420767875072)]} 0 5
[junit4:junit4]   2> 14391 T1167 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[10100 (-1426108420766826496)]} 0 3
[junit4:junit4]   2> 14391 T1151 C101 P53339 /update {wt=javabin&version=2} {delete=[10100 (-1426108420766826496)]} 0 6
[junit4:junit4]   2> 14394 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[132 (1426108420776263680)]} 0 1
[junit4:junit4]   2> 14395 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10124 (1426108420777312256)]} 0 0
[junit4:junit4]   2> 14399 T1169 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[132 (1426108420778360832)]} 0 1
[junit4:junit4]   2> 14400 T1165 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10124 (1426108420779409408)]} 0 0
[junit4:junit4]   2> 14401 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[10124 (1426108420779409408)]} 0 4
[junit4:junit4]   2> 14403 T1153 C101 P53339 /update {wt=javabin&version=2} {add=[132 (1426108420778360832)]} 0 7
[junit4:junit4]   2> 14405 T1136 C100 P53327 /update {wt=javabin&version=2} {delete=[108 (-1426108420787798016)]} 0 0
[junit4:junit4]   2> 14406 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[10125 (1426108420788846592)]} 0 0
[junit4:junit4]   2> 14411 T1170 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[108 (-1426108420790943744)]} 0 1
[junit4:junit4]   2> 14415 T1166 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10125 (1426108420791992320)]} 0 3
[junit4:junit4]   2> 14416 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10125 (1426108420791992320)]} 0 7
[junit4:junit4]   2> 14417 T1155 C101 P53339 /update {wt=javabin&version=2} {delete=[108 (-1426108420790943744)]} 0 9
[junit4:junit4]   2> 14419 T1134 C100 P53327 /update {wt=javabin&version=2} {delete=[10102 (-1426108420802478080)]} 0 0
[junit4:junit4]   2> 14420 T1132 C100 P53327 /update {wt=javabin&version=2} {add=[133 (1426108420803526656)]} 0 0
[junit4:junit4]   2> 14425 T1168 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[10102 (-1426108420806672384)]} 0 0
[junit4:junit4]   2> 14427 T1168 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[133 (1426108420807720960)]} 0 1
[junit4:junit4]   2> 14428 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[133 (1426108420807720960)]} 0 5
[junit4:junit4]   2> 14429 T1151 C101 P53339 /update {wt=javabin&version=2} {delete=[10102 (-1426108420806672384)]} 0 6
[junit4:junit4]   2> 14431 T1131 C100 P53327 /update {wt=javabin&version=2} {delete=[110 (-1426108420815060992)]} 0 0
[junit4:junit4]   2> 14433 T1133 C100 P53327 /update {wt=javabin&version=2} {add=[10126 (1426108420817158144)]} 0 0
[junit4:junit4]   2> 14437 T1169 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[110 (-1426108420818206720)]} 0 0
[junit4:junit4]   2> 14439 T1153 C101 P53339 /update {wt=javabin&version=2} {delete=[110 (-1426108420818206720)]} 0 5
[junit4:junit4]   2> 14441 T1165 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10126 (1426108420820303872)]} 0 1
[junit4:junit4]   2> 14442 T1152 C101 P53339 /update {wt=javabin&version=2} {add=[10126 (1426108420820303872)]} 0 6
[junit4:junit4]   2> 14446 T1136 C100 P53327 /update {wt=javabin&version=2} {add=[134 (1426108420827643904)]} 0 3
[junit4:junit4]   2> 14454 T1134 C100 P53327 /update {wt=javabin&version=2} {add=[10127 (1426108420839178240)]} 0 0
[junit4:junit4]   2> 14457 T1170 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[134 (1426108420834983936)]} 0 1
[junit4:junit4]   2> 14458 T1154 C101 P53339 /update {wt=javabin&version=2} {add=[134 (1426108420834983936)]} 0 8
[junit4:junit4]   2> 14461 T1132 C100 P53327 /update {wt=javabin&version=2} {delete=[111 (-1426108420846518272)]} 0 0
[junit4:junit4]   2> 14465 T1166 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10127 (1426108420847566848)]} 0 0
[junit4:junit4]   2> 14467 T1168 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[111 (-1426108420849664000)]} 0 0
[junit4:junit4]   2> 14468 T1151 C101 P53339 /update {wt=javabin&version=2} {add=[10127 (1426108420847566848)]} 0 6
[junit4:junit4]   2> 14469 T1153 C101 P53339 /update {wt=javabin&version=2} {delete=[111 (-1426108420849664000)]} 0 5
[junit4:junit4]   2> 14481 T1131 C100 P53327 /update {wt=javabin&version=2} {add=[135 (1426108420867489792)]} 0 0
[junit4:junit4]   2> 14483 T1133 C100 P53327 /update {wt=javabin&version=2} {delete=[10104 (-1426108420869586944)]} 0 0
[junit4:junit4]   2> 14492 T1167 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[10104 (-1426108420870635520)]} 0 6
[junit4:junit4]   2> 14494 T1167 C99 P53348 /update {distrib.from=http://127.0.0.1:53339/_vua/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[135 (1426108420869586944)]} 0 1
[junit4:junit4]   2> 14495 T1152 C101 P53339 /update 

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

org.apache.solr.cloud.RecoveryZkTest-1360042958916\jetty2\index
[junit4:junit4]   2> 105337 T1118 oasc.CachingDirectoryFactory.closeDirectory Closing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1360042958916\jetty2\index
[junit4:junit4]   2> 105738 T1118 oaz.ZooKeeper.close Session: 0x13ca8e0a052000a closed
[junit4:junit4]   2> 105739 T1221 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 105753 T1118 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/_vua,null}
[junit4:junit4]   2> 105954 T1118 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
[junit4:junit4]   1> client port:0.0.0.0/0.0.0.0:0
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=RecoveryZkTest -Dtests.method=testDistribSearch -Dtests.seed=9539959EDD47197B -Dtests.slow=true -Dtests.locale=zh_TW -Dtests.timezone=Europe/Jersey -Dtests.file.encoding=Cp1252
[junit4:junit4] FAILURE  106s | RecoveryZkTest.testDistribSearch <<<
[junit4:junit4]    > Throwable #1: java.lang.AssertionError: expected:<376> but was:<2>
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([9539959EDD47197B:14DF1B86AA187947]:0)
[junit4:junit4]    > 	at org.junit.Assert.fail(Assert.java:93)
[junit4:junit4]    > 	at org.junit.Assert.failNotEquals(Assert.java:647)
[junit4:junit4]    > 	at org.junit.Assert.assertEquals(Assert.java:128)
[junit4:junit4]    > 	at org.junit.Assert.assertEquals(Assert.java:472)
[junit4:junit4]    > 	at org.junit.Assert.assertEquals(Assert.java:456)
[junit4:junit4]    > 	at org.apache.solr.cloud.RecoveryZkTest.doTest(RecoveryZkTest.java:106)
[junit4:junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:794)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
[junit4:junit4]    > 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4:junit4]    > 	at java.lang.reflect.Method.invoke(Method.java:601)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[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:49)
[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:46)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 105980 T1118 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4]   2> NOTE: test params are: codec=Lucene42: {range_facet_l=Lucene41(blocksize=128), text=Pulsing41(freqCutoff=3 minBlockSize=56 maxBlockSize=120), _version_=Lucene41(blocksize=128), rnd_b=Pulsing41(freqCutoff=4 minBlockSize=56 maxBlockSize=120), intDefault=Lucene41(blocksize=128), timestamp=Lucene41(blocksize=128), id=Pulsing41(freqCutoff=4 minBlockSize=56 maxBlockSize=120), a_t=Lucene41(blocksize=128), range_facet_sl=Pulsing41(freqCutoff=3 minBlockSize=56 maxBlockSize=120), range_facet_si=PostingsFormat(name=MockRandom), other_tl1=Lucene41(blocksize=128), multiDefault=PostingsFormat(name=MockRandom), a_si=PostingsFormat(name=MockRandom)}, sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {}, locale=zh_TW, timezone=Europe/Jersey
[junit4:junit4]   2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.7.0_10 (32-bit)/cpus=2,threads=1,free=137199584,total=282750976
[junit4:junit4]   2> NOTE: All tests run in this JVM: [EchoParamsTest, JsonLoaderTest, TestStressReorder, MultiTermTest, DateFieldTest, TestQuerySenderListener, SolrInfoMBeanTest, WordBreakSolrSpellCheckerTest, TestWriterPerf, TestPropInject, AutoCommitTest, TestFaceting, DebugComponentTest, TestHashPartitioner, DefaultValueUpdateProcessorTest, SystemInfoHandlerTest, DirectSolrConnectionTest, OutputWriterTest, CoreAdminHandlerTest, TestPHPSerializedResponseWriter, SuggesterFSTTest, IndexSchemaRuntimeFieldTest, TestDistributedGrouping, SolrCoreTest, UpdateParamsTest, PrimitiveFieldTypeTest, TestSort, TestReload, SimplePostToolTest, QueryElevationComponentTest, TestBadConfig, ShardRoutingTest, HighlighterConfigTest, SolrCoreCheckLockOnStartupTest, ScriptEngineTest, IndexReaderFactoryTest, BasicDistributedZkTest, TestAnalyzedSuggestions, PingRequestHandlerTest, UpdateRequestProcessorFactoryTest, AlternateDirectoryTest, ConvertedLegacyTest, TestBM25SimilarityFactory, SpellCheckComponentTest, TestMergePolicyConfig, TestIBSimilarityFactory, TestUtils, TestDefaultSimilarityFactory, NoCacheHeaderTest, OpenExchangeRatesOrgProviderTest, RecoveryZkTest]
[junit4:junit4] Completed in 106.02s, 1 test, 1 failure <<< FAILURES!

[...truncated 615 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:346: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:39: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:178: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:428: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1176: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:841: There were test failures: 249 suites, 1038 tests, 1 failure, 14 ignored (9 assumptions)

Total time: 52 minutes 59 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Description set: Java: 32bit/jdk1.7.0_10 -client -XX:+UseConcMarkSweepGC
Email was triggered for: Failure
Sending email for trigger: Failure



Mime
View raw message