You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2013/01/27 07:50:40 UTC
[JENKINS] Lucene-Solr-trunk-Windows (32bit/jdk1.7.0_10) - Build #
2466 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/2466/
Java: 32bit/jdk1.7.0_10 -server -XX:+UseConcMarkSweepGC
1 tests failed.
REGRESSION: org.apache.solr.cloud.RecoveryZkTest.testDistribSearch
Error Message:
expected:<244> but was:<2>
Stack Trace:
java.lang.AssertionError: expected:<244> but was:<2>
at __randomizedtesting.SeedInfo.seed([13BD914BC7EE6157:925B1F53B0B1016B]: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 8990 lines...]
[junit4:junit4] Suite: org.apache.solr.cloud.RecoveryZkTest
[junit4:junit4] 2> 0 T2733 oas.SolrTestCaseJ4.startTrackingSearchers WARNING startTrackingSearchers: numOpens=2 numCloses=2
[junit4:junit4] 2> 1 T2733 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /y_/n
[junit4:junit4] 2> 4 T2733 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-1359268679962
[junit4:junit4] 2> 8 T2733 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4] 2> 9 T2734 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server
[junit4:junit4] 2> 12 T2734 oazs.ZooKeeperServer.setTickTime tickTime set to 1000
[junit4:junit4] 2> 12 T2734 oazs.ZooKeeperServer.setMinSessionTimeout minSessionTimeout set to -1
[junit4:junit4] 2> 12 T2734 oazs.ZooKeeperServer.setMaxSessionTimeout maxSessionTimeout set to -1
[junit4:junit4] 2> 13 T2734 oazs.NIOServerCnxnFactory.configure binding to port 0.0.0.0/0.0.0.0:0
[junit4:junit4] 2> 14 T2734 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-1359268679961\zookeeper\server1\data\version-2\snapshot.0
[junit4:junit4] 2> 107 T2733 oasc.ZkTestServer.run start zk server on port:59481
[junit4:junit4] 2> 107 T2733 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:59481 sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@b33284
[junit4:junit4] 2> 108 T2733 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 110 T2739 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server 127.0.0.1/127.0.0.1:59481. Will not attempt to authenticate using SASL (access denied ("javax.security.auth.AuthPermission" "getLoginConfiguration"))
[junit4:junit4] 2> 110 T2739 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to 127.0.0.1/127.0.0.1:59481, initiating session
[junit4:junit4] 2> 110 T2735 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:59484
[junit4:junit4] 2> 111 T2735 oazs.ZooKeeperServer.processConnectRequest Client attempting to establish new session at /127.0.0.1:59484
[junit4:junit4] 2> 111 T2737 oazsp.FileTxnLog.append Creating new log file: log.1
[junit4:junit4] 2> 115 T2737 oazs.ZooKeeperServer.finishSessionInit Established session 0x13c7aba11220000 with negotiated timeout 10000 for client /127.0.0.1:59484
[junit4:junit4] 2> 115 T2739 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server 127.0.0.1/127.0.0.1:59481, sessionid = 0x13c7aba11220000, negotiated timeout = 10000
[junit4:junit4] 2> 116 T2740 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@b33284 name:ZooKeeperConnection Watcher:127.0.0.1:59481 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 116 T2733 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 116 T2733 oascc.SolrZkClient.makePath makePath: /solr
[junit4:junit4] 2> 120 T2738 oazs.PrepRequestProcessor.pRequest2Txn Processed session termination for sessionid: 0x13c7aba11220000
[junit4:junit4] 2> 122 T2740 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4] 2> 121 T2733 oaz.ZooKeeper.close Session: 0x13c7aba11220000 closed
[junit4:junit4] 2> 122 T2735 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:59484 which had sessionid 0x13c7aba11220000
[junit4:junit4] 2> 123 T2733 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:59481/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@1a1ccac
[junit4:junit4] 2> 124 T2733 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 124 T2741 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server 127.0.0.1/127.0.0.1:59481. Will not attempt to authenticate using SASL (access denied ("javax.security.auth.AuthPermission" "getLoginConfiguration"))
[junit4:junit4] 2> 125 T2741 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to 127.0.0.1/127.0.0.1:59481, initiating session
[junit4:junit4] 2> 125 T2735 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:59487
[junit4:junit4] 2> 125 T2735 oazs.ZooKeeperServer.processConnectRequest Client attempting to establish new session at /127.0.0.1:59487
[junit4:junit4] 2> 126 T2737 oazs.ZooKeeperServer.finishSessionInit Established session 0x13c7aba11220001 with negotiated timeout 10000 for client /127.0.0.1:59487
[junit4:junit4] 2> 126 T2741 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server 127.0.0.1/127.0.0.1:59481, sessionid = 0x13c7aba11220001, negotiated timeout = 10000
[junit4:junit4] 2> 127 T2742 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1a1ccac name:ZooKeeperConnection Watcher:127.0.0.1:59481/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 127 T2733 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 127 T2733 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4:junit4] 2> 132 T2733 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4:junit4] 2> 136 T2733 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4:junit4] 2> 139 T2733 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4:junit4] 2> 143 T2733 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> 144 T2733 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4] 2> 150 T2733 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> 151 T2733 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4:junit4] 2> 155 T2733 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> 156 T2733 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
[junit4:junit4] 2> 160 T2733 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> 160 T2733 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
[junit4:junit4] 2> 164 T2733 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> 165 T2733 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
[junit4:junit4] 2> 169 T2733 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> 169 T2733 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
[junit4:junit4] 2> 173 T2733 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> 173 T2733 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4] 2> 177 T2733 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> 177 T2733 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
[junit4:junit4] 2> 181 T2733 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> 182 T2733 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
[junit4:junit4] 2> 186 T2738 oazs.PrepRequestProcessor.pRequest2Txn Processed session termination for sessionid: 0x13c7aba11220001
[junit4:junit4] 2> 187 T2742 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4] 2> 188 T2735 oazs.NIOServerCnxn.doIO WARNING caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x13c7aba11220001, 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> 187 T2733 oaz.ZooKeeper.close Session: 0x13c7aba11220001 closed
[junit4:junit4] 2> 188 T2735 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:59487 which had sessionid 0x13c7aba11220001
[junit4:junit4] 2> 491 T2733 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4] 2> 499 T2733 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:59488
[junit4:junit4] 2> 499 T2733 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4] 2> 500 T2733 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4] 2> 500 T2733 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-1359268680144
[junit4:junit4] 2> 500 T2733 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-1359268680144\solr.xml
[junit4:junit4] 2> 500 T2733 oasc.CoreContainer.<init> New CoreContainer 10260589
[junit4:junit4] 2> 501 T2733 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-1359268680144\'
[junit4:junit4] 2> 501 T2733 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-1359268680144\'
[junit4:junit4] 2> 541 T2733 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 60000
[junit4:junit4] 2> 541 T2733 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4] 2> 542 T2733 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4:junit4] 2> 542 T2733 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4] 2> 542 T2733 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4] 2> 542 T2733 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4] 2> 542 T2733 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4] 2> 543 T2733 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4] 2> 543 T2733 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4] 2> 544 T2733 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=60000&connTimeout=15000&retry=false
[junit4:junit4] 2> 557 T2733 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4] 2> 583 T2733 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:59481/solr
[junit4:junit4] 2> 584 T2733 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4:junit4] 2> 584 T2733 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:59481 sessionTimeout=60000 watcher=org.apache.solr.common.cloud.ConnectionManager@1451698
[junit4:junit4] 2> 585 T2733 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 586 T2752 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server 127.0.0.1/127.0.0.1:59481. Will not attempt to authenticate using SASL (access denied ("javax.security.auth.AuthPermission" "getLoginConfiguration"))
[junit4:junit4] 2> 587 T2752 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to 127.0.0.1/127.0.0.1:59481, initiating session
[junit4:junit4] 2> 587 T2735 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:59493
[junit4:junit4] 2> 587 T2735 oazs.ZooKeeperServer.processConnectRequest Client attempting to establish new session at /127.0.0.1:59493
[junit4:junit4] 2> 595 T2737 oazs.ZooKeeperServer.finishSessionInit Established session 0x13c7aba11220002 with negotiated timeout 20000 for client /127.0.0.1:59493
[junit4:junit4] 2> 595 T2752 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server 127.0.0.1/127.0.0.1:59481, sessionid = 0x13c7aba11220002, negotiated timeout = 20000
[junit4:junit4] 2> 596 T2753 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1451698 name:ZooKeeperConnection Watcher:127.0.0.1:59481 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 596 T2733 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 597 T2738 oazs.PrepRequestProcessor.pRequest2Txn Processed session termination for sessionid: 0x13c7aba11220002
[junit4:junit4] 2> 599 T2753 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4] 2> 599 T2735 oazs.NIOServerCnxn.doIO WARNING caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x13c7aba11220002, 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> 600 T2735 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:59493 which had sessionid 0x13c7aba11220002
[junit4:junit4] 2> 599 T2733 oaz.ZooKeeper.close Session: 0x13c7aba11220002 closed
[junit4:junit4] 2> 601 T2733 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=500&maxConnectionsPerHost=16&socketTimeout=60000&connTimeout=15000
[junit4:junit4] 2> 605 T2733 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:59481/solr sessionTimeout=30000 watcher=org.apache.solr.common.cloud.ConnectionManager@bde4b5
[junit4:junit4] 2> 607 T2733 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 608 T2754 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server 127.0.0.1/127.0.0.1:59481. Will not attempt to authenticate using SASL (access denied ("javax.security.auth.AuthPermission" "getLoginConfiguration"))
[junit4:junit4] 2> 609 T2754 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to 127.0.0.1/127.0.0.1:59481, initiating session
[junit4:junit4] 2> 609 T2735 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:59496
[junit4:junit4] 2> 609 T2735 oazs.ZooKeeperServer.processConnectRequest Client attempting to establish new session at /127.0.0.1:59496
[junit4:junit4] 2> 611 T2737 oazs.ZooKeeperServer.finishSessionInit Established session 0x13c7aba11220003 with negotiated timeout 20000 for client /127.0.0.1:59496
[junit4:junit4] 2> 611 T2754 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server 127.0.0.1/127.0.0.1:59481, sessionid = 0x13c7aba11220003, negotiated timeout = 20000
[junit4:junit4] 2> 611 T2755 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@bde4b5 name:ZooKeeperConnection Watcher:127.0.0.1:59481/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 612 T2733 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 614 T2738 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c7aba11220003 type:create cxid:0x2 zxid:0x1a txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4] 2> 615 T2733 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4:junit4] 2> 617 T2733 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59488_y_%2Fn
[junit4:junit4] 2> 618 T2738 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c7aba11220003 type:delete cxid:0x7 zxid:0x1c txntype:-1 reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:59488_y_%2Fn Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:59488_y_%2Fn
[junit4:junit4] 2> 620 T2733 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:59488_y_%2Fn
[junit4:junit4] 2> 624 T2733 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4:junit4] 2> 632 T2738 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c7aba11220003 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> 633 T2733 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4] 2> 636 T2733 oasc.Overseer.start Overseer (id=89081032210513923-127.0.0.1:59488_y_%2Fn-n_0000000000) starting
[junit4:junit4] 2> 637 T2738 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c7aba11220003 type:create cxid:0x1a zxid:0x23 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4] 2> 639 T2738 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c7aba11220003 type:create cxid:0x1b zxid:0x24 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4] 2> 640 T2738 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c7aba11220003 type:create cxid:0x1c zxid:0x25 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4] 2> 641 T2738 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c7aba11220003 type:create cxid:0x1d zxid:0x26 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4] 2> 643 T2757 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
[junit4:junit4] 2> 644 T2733 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4:junit4] 2> 648 T2733 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4:junit4] 2> 651 T2756 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4] 2> 657 T2758 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-1359268680144\collection1
[junit4:junit4] 2> 657 T2758 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection
[junit4:junit4] 2> 658 T2758 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4] 2> 658 T2758 oasc.ZkController.readConfigName Load collection config from:/collections/control_collection
[junit4:junit4] 2> 660 T2758 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-1359268680144\collection1\'
[junit4:junit4] 2> 661 T2758 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-1359268680144/collection1/lib/classes/' to classloader
[junit4:junit4] 2> 662 T2758 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-1359268680144/collection1/lib/README' to classloader
[junit4:junit4] 2> 715 T2758 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4] 2> 790 T2758 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4] 2> 792 T2758 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4] 2> 796 T2758 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4] 2> 1468 T2758 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4] 2> 1481 T2758 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4] 2> 1487 T2758 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4] 2> 1510 T2758 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 1517 T2758 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 1523 T2758 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 1526 T2758 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 1527 T2758 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-1359268680144\collection1\, dataDir=.\org.apache.solr.cloud.RecoveryZkTest-1359268679961/control/data\
[junit4:junit4] 2> 1528 T2758 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1b04fbf
[junit4:junit4] 2> 1528 T2758 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4] 2> 1529 T2758 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-1359268679961\control\data forceNew:false
[junit4:junit4] 2> 1529 T2758 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1359268679961\control\data
[junit4:junit4] 2> 1529 T2758 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=.\org.apache.solr.cloud.RecoveryZkTest-1359268679961/control/data\index/
[junit4:junit4] 2> 1530 T2758 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '.\org.apache.solr.cloud.RecoveryZkTest-1359268679961\control\data\index' doesn't exist. Creating new index...
[junit4:junit4] 2> 1531 T2758 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-1359268679961\control\data\index forceNew:false
[junit4:junit4] 2> 1534 T2758 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@1083941 lockFactory=org.apache.lucene.store.NativeFSLockFactory@ddd7f6)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> 1535 T2758 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4] 2> 1536 T2758 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1359268679961\control\data\index
[junit4:junit4] 2> 1536 T2758 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4] 2> 1539 T2758 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4] 2> 1539 T2758 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4] 2> 1539 T2758 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4] 2> 1539 T2758 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4] 2> 1540 T2758 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4] 2> 1540 T2758 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4] 2> 1540 T2758 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4] 2> 1541 T2758 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4] 2> 1541 T2758 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4] 2> 1542 T2758 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4] 2> 1542 T2758 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4] 2> 1542 T2758 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4] 2> 1543 T2758 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4] 2> 1543 T2758 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4] 2> 1543 T2758 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4] 2> 1544 T2758 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4] 2> 1544 T2758 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 1544 T2758 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 1545 T2758 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 1545 T2758 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 1546 T2758 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 1546 T2758 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 1546 T2758 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 1548 T2758 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 1548 T2758 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4] 2> 1548 T2758 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4] 2> 1559 T2758 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4] 2> 1565 T2758 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4] 2> 1567 T2758 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> 1569 T2758 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1359268679961\control\data
[junit4:junit4] 2> 1569 T2758 oass.SolrIndexSearcher.<init> Opening Searcher@1c27960 main
[junit4:junit4] 2> 1571 T2758 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4] 2> 1572 T2758 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4] 2> 1572 T2758 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4] 2> 1584 T2758 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4] 2> 1639 T2759 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1c27960 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4] 2> 1642 T2758 oasc.ZkController.publish publishing core=collection1 state=down
[junit4:junit4] 2> 1642 T2758 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4] 2> 1643 T2738 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c7aba11220003 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> 2125 T2756 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 2126 T2756 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:59488_y_%2Fn",
[junit4:junit4] 2> "base_url":"http://127.0.0.1:59488/y_/n"}
[junit4:junit4] 2> 2126 T2756 oasc.Overseer$ClusterStateUpdater.createCollection Create collection control_collection with numShards 1
[junit4:junit4] 2> 2127 T2756 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1
[junit4:junit4] 2> 2127 T2738 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c7aba11220003 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> 2137 T2755 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> 2627 T2758 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4] 2> 2627 T2758 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:59488/y_/n collection:control_collection shard:shard1
[junit4:junit4] 2> 2628 T2758 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/shard1/election
[junit4:junit4] 2> 2639 T2738 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c7aba11220003 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> 2641 T2758 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4] 2> 2641 T2738 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c7aba11220003 type:create cxid:0x73 zxid:0x37 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4] 2> 2645 T2758 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4] 2> 2645 T2758 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4] 2> 2645 T2758 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:59488/y_/n/collection1/
[junit4:junit4] 2> 2645 T2758 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4:junit4] 2> 2645 T2758 oasc.SyncStrategy.syncToMe http://127.0.0.1:59488/y_/n/collection1/ has no replicas
[junit4:junit4] 2> 2646 T2758 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:59488/y_/n/collection1/
[junit4:junit4] 2> 2646 T2758 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/shard1
[junit4:junit4] 2> 2651 T2738 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c7aba11220003 type:create cxid:0x7d zxid:0x3b txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4] 2> 3612 T2756 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 3626 T2755 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> 3651 T2758 oasc.ZkController.register We are http://127.0.0.1:59488/y_/n/collection1/ and leader is http://127.0.0.1:59488/y_/n/collection1/
[junit4:junit4] 2> 3651 T2758 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:59488/y_/n
[junit4:junit4] 2> 3651 T2758 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4] 2> 3651 T2758 oasc.ZkController.publish publishing core=collection1 state=active
[junit4:junit4] 2> 3651 T2758 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4] 2> 3653 T2758 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 3654 T2733 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4:junit4] 2> 3654 T2733 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4] 2> 3654 T2733 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 2> 3663 T2733 oascsi.HttpClientUtil.createClient Creating new http client, config:
[junit4:junit4] 2> 3668 T2733 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:59481/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@8571e3
[junit4:junit4] 2> 3670 T2733 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 3671 T2760 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server 127.0.0.1/127.0.0.1:59481. Will not attempt to authenticate using SASL (access denied ("javax.security.auth.AuthPermission" "getLoginConfiguration"))
[junit4:junit4] 2> 3671 T2760 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to 127.0.0.1/127.0.0.1:59481, initiating session
[junit4:junit4] 2> 3671 T2735 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:59499
[junit4:junit4] 2> 3672 T2735 oazs.ZooKeeperServer.processConnectRequest Client attempting to establish new session at /127.0.0.1:59499
[junit4:junit4] 2> 3679 T2737 oazs.ZooKeeperServer.finishSessionInit Established session 0x13c7aba11220004 with negotiated timeout 10000 for client /127.0.0.1:59499
[junit4:junit4] 2> 3679 T2760 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server 127.0.0.1/127.0.0.1:59481, sessionid = 0x13c7aba11220004, negotiated timeout = 10000
[junit4:junit4] 2> 3679 T2761 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@8571e3 name:ZooKeeperConnection Watcher:127.0.0.1:59481/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 3679 T2733 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 3680 T2733 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4:junit4] 2> 3682 T2733 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:true cause connection loss:true
[junit4:junit4] 2> 3995 T2733 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4] 2> 3999 T2733 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:59500
[junit4:junit4] 2> 4000 T2733 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4] 2> 4000 T2733 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4] 2> 4000 T2733 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-1359268683638
[junit4:junit4] 2> 4001 T2733 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-1359268683638\solr.xml
[junit4:junit4] 2> 4001 T2733 oasc.CoreContainer.<init> New CoreContainer 21805491
[junit4:junit4] 2> 4002 T2733 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-1359268683638\'
[junit4:junit4] 2> 4002 T2733 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-1359268683638\'
[junit4:junit4] 2> 4047 T2733 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 60000
[junit4:junit4] 2> 4048 T2733 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4] 2> 4049 T2733 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4:junit4] 2> 4049 T2733 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4] 2> 4049 T2733 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4] 2> 4049 T2733 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4] 2> 4050 T2733 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4] 2> 4050 T2733 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4] 2> 4050 T2733 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4] 2> 4050 T2733 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=60000&connTimeout=15000&retry=false
[junit4:junit4] 2> 4064 T2733 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4] 2> 4083 T2733 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:59481/solr
[junit4:junit4] 2> 4083 T2733 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4:junit4] 2> 4084 T2733 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:59481 sessionTimeout=60000 watcher=org.apache.solr.common.cloud.ConnectionManager@2e9762
[junit4:junit4] 2> 4086 T2733 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 4086 T2771 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server 127.0.0.1/127.0.0.1:59481. Will not attempt to authenticate using SASL (access denied ("javax.security.auth.AuthPermission" "getLoginConfiguration"))
[junit4:junit4] 2> 4087 T2771 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to 127.0.0.1/127.0.0.1:59481, initiating session
[junit4:junit4] 2> 4087 T2735 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:59505
[junit4:junit4] 2> 4088 T2735 oazs.ZooKeeperServer.processConnectRequest Client attempting to establish new session at /127.0.0.1:59505
[junit4:junit4] 2> 4097 T2771 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server 127.0.0.1/127.0.0.1:59481, sessionid = 0x13c7aba11220005, negotiated timeout = 20000
[junit4:junit4] 2> 4097 T2737 oazs.ZooKeeperServer.finishSessionInit Established session 0x13c7aba11220005 with negotiated timeout 20000 for client /127.0.0.1:59505
[junit4:junit4] 2> 4098 T2772 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@2e9762 name:ZooKeeperConnection Watcher:127.0.0.1:59481 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 4098 T2733 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 4100 T2738 oazs.PrepRequestProcessor.pRequest2Txn Processed session termination for sessionid: 0x13c7aba11220005
[junit4:junit4] 2> 4102 T2735 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:59505 which had sessionid 0x13c7aba11220005
[junit4:junit4] 2> 4102 T2772 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4] 2> 4102 T2733 oaz.ZooKeeper.close Session: 0x13c7aba11220005 closed
[junit4:junit4] 2> 4103 T2733 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=500&maxConnectionsPerHost=16&socketTimeout=60000&connTimeout=15000
[junit4:junit4] 2> 4109 T2733 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:59481/solr sessionTimeout=30000 watcher=org.apache.solr.common.cloud.ConnectionManager@24c0e4
[junit4:junit4] 2> 4110 T2733 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 4111 T2773 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server 127.0.0.1/127.0.0.1:59481. Will not attempt to authenticate using SASL (access denied ("javax.security.auth.AuthPermission" "getLoginConfiguration"))
[junit4:junit4] 2> 4112 T2773 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to 127.0.0.1/127.0.0.1:59481, initiating session
[junit4:junit4] 2> 4112 T2735 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:59508
[junit4:junit4] 2> 4112 T2735 oazs.ZooKeeperServer.processConnectRequest Client attempting to establish new session at /127.0.0.1:59508
[junit4:junit4] 2> 4114 T2737 oazs.ZooKeeperServer.finishSessionInit Established session 0x13c7aba11220006 with negotiated timeout 20000 for client /127.0.0.1:59508
[junit4:junit4] 2> 4114 T2773 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server 127.0.0.1/127.0.0.1:59481, sessionid = 0x13c7aba11220006, negotiated timeout = 20000
[junit4:junit4] 2> 4114 T2774 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@24c0e4 name:ZooKeeperConnection Watcher:127.0.0.1:59481/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 4116 T2733 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 4121 T2738 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c7aba11220006 type:create cxid:0x1 zxid:0x49 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4] 2> 4125 T2738 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c7aba11220006 type:create cxid:0x2 zxid:0x4a txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4] 2> 4128 T2733 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59500_y_%2Fn
[junit4:junit4] 2> 4128 T2738 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c7aba11220006 type:delete cxid:0x4 zxid:0x4b txntype:-1 reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:59500_y_%2Fn Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:59500_y_%2Fn
[junit4:junit4] 2> 4130 T2733 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:59500_y_%2Fn
[junit4:junit4] 2> 4133 T2755 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> 4134 T2761 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4:junit4] 2> 4137 T2755 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4:junit4] 2> 4138 T2733 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4:junit4] 2> 4151 T2775 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-1359268683638\collection1
[junit4:junit4] 2> 4151 T2775 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4] 2> 4152 T2775 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4] 2> 4152 T2775 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4] 2> 4155 T2775 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-1359268683638\collection1\'
[junit4:junit4] 2> 4156 T2775 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-1359268683638/collection1/lib/classes/' to classloader
[junit4:junit4] 2> 4157 T2775 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-1359268683638/collection1/lib/README' to classloader
[junit4:junit4] 2> 4209 T2775 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4] 2> 4280 T2775 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4] 2> 4282 T2775 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4] 2> 4287 T2775 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4] 2> 4961 T2775 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4] 2> 4970 T2775 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4] 2> 4974 T2775 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4] 2> 4989 T2775 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 4994 T2775 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 4999 T2775 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 5001 T2775 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 5002 T2775 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-1359268683638\collection1\, dataDir=.\org.apache.solr.cloud.RecoveryZkTest-1359268679961/jetty1\
[junit4:junit4] 2> 5002 T2775 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1b04fbf
[junit4:junit4] 2> 5003 T2775 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4] 2> 5003 T2775 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-1359268679961\jetty1 forceNew:false
[junit4:junit4] 2> 5003 T2775 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1359268679961\jetty1
[junit4:junit4] 2> 5003 T2775 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=.\org.apache.solr.cloud.RecoveryZkTest-1359268679961/jetty1\index/
[junit4:junit4] 2> 5005 T2775 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '.\org.apache.solr.cloud.RecoveryZkTest-1359268679961\jetty1\index' doesn't exist. Creating new index...
[junit4:junit4] 2> 5005 T2775 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-1359268679961\jetty1\index forceNew:false
[junit4:junit4] 2> 5008 T2775 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@10634d0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1b55a63)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> 5008 T2775 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4] 2> 5010 T2775 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1359268679961\jetty1\index
[junit4:junit4] 2> 5010 T2775 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4] 2> 5012 T2775 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4] 2> 5012 T2775 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4] 2> 5012 T2775 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4] 2> 5012 T2775 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4] 2> 5012 T2775 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4] 2> 5012 T2775 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4] 2> 5012 T2775 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4] 2> 5013 T2775 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4] 2> 5013 T2775 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4] 2> 5019 T2775 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4] 2> 5020 T2775 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4] 2> 5020 T2775 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4] 2> 5020 T2775 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4] 2> 5020 T2775 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4] 2> 5020 T2775 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4] 2> 5021 T2775 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4] 2> 5021 T2775 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 5022 T2775 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 5022 T2775 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 5022 T2775 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 5023 T2775 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 5023 T2775 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 5024 T2775 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 5024 T2775 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 5024 T2775 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4] 2> 5025 T2775 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4] 2> 5035 T2775 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4] 2> 5040 T2775 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4] 2> 5042 T2775 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> 5045 T2775 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1359268679961\jetty1
[junit4:junit4] 2> 5045 T2775 oass.SolrIndexSearcher.<init> Opening Searcher@10d6b7f main
[junit4:junit4] 2> 5047 T2775 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4] 2> 5047 T2775 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4] 2> 5047 T2775 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4] 2> 5058 T2775 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4] 2> 5107 T2756 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 5109 T2756 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:59488_y_%2Fn",
[junit4:junit4] 2> "base_url":"http://127.0.0.1:59488/y_/n"}
[junit4:junit4] 2> 5120 T2774 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> 5120 T2761 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> 5120 T2755 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> 5124 T2776 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@10d6b7f main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4] 2> 5128 T2775 oasc.ZkController.publish publishing core=collection1 state=down
[junit4:junit4] 2> 5129 T2775 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4] 2> 6598 T2756 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 6599 T2756 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:59500_y_%2Fn",
[junit4:junit4] 2> "base_url":"http://127.0.0.1:59500/y_/n"}
[junit4:junit4] 2> 6599 T2756 oasc.Overseer$ClusterStateUpdater.createCollection Create collection collection1 with numShards 1
[junit4:junit4] 2> 6600 T2756 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1
[junit4:junit4] 2> 6608 T2774 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> 6609 T2761 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> 6609 T2755 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> 7091 T2775 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4] 2> 7091 T2775 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:59500/y_/n collection:collection1 shard:shard1
[junit4:junit4] 2> 7092 T2775 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election
[junit4:junit4] 2> 7108 T2738 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c7aba11220006 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> 7109 T2775 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4] 2> 7109 T2738 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c7aba11220006 type:create cxid:0x46 zxid:0x5c txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4] 2> 7113 T2775 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4] 2> 7114 T2775 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4] 2> 7114 T2775 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:59500/y_/n/collection1/
[junit4:junit4] 2> 7114 T2775 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4:junit4] 2> 7114 T2775 oasc.SyncStrategy.syncToMe http://127.0.0.1:59500/y_/n/collection1/ has no replicas
[junit4:junit4] 2> 7115 T2775 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:59500/y_/n/collection1/
[junit4:junit4] 2> 7115 T2775 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4:junit4] 2> 7122 T2738 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c7aba11220006 type:create cxid:0x50 zxid:0x60 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4] 2> 8085 T2756 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 8099 T2774 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> 8100 T2761 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> 8100 T2755 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> 8122 T2775 oasc.ZkController.register We are http://127.0.0.1:59500/y_/n/collection1/ and leader is http://127.0.0.1:59500/y_/n/collection1/
[junit4:junit4] 2> 8122 T2775 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:59500/y_/n
[junit4:junit4] 2> 8122 T2775 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4] 2> 8122 T2775 oasc.ZkController.publish publishing core=collection1 state=active
[junit4:junit4] 2> 8122 T2775 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4] 2> 8125 T2775 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 8126 T2733 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4:junit4] 2> 8126 T2733 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4] 2> 8126 T2733 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 2> 8496 T2733 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4] 2> 8501 T2733 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:59509
[junit4:junit4] 2> 8502 T2733 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4] 2> 8503 T2733 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4] 2> 8503 T2733 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-1359268688091
[junit4:junit4] 2> 8503 T2733 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-1359268688091\solr.xml
[junit4:junit4] 2> 8503 T2733 oasc.CoreContainer.<init> New CoreContainer 17803200
[junit4:junit4] 2> 8504 T2733 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-1359268688091\'
[junit4:junit4] 2> 8504 T2733 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-1359268688091\'
[junit4:junit4] 2> 8556 T2733 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 60000
[junit4:junit4] 2> 8556 T2733 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4] 2> 8556 T2733 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4:junit4] 2> 8557 T2733 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4] 2> 8557 T2733 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4] 2> 8558 T2733 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4] 2> 8558 T2733 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4] 2> 8558 T2733 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4] 2> 8559 T2733 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4] 2> 8559 T2733 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=60000&connTimeout=15000&retry=false
[junit4:junit4] 2> 8580 T2733 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4] 2> 8600 T2733 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:59481/solr
[junit4:junit4] 2> 8601 T2733 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4:junit4] 2> 8601 T2733 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:59481 sessionTimeout=60000 watcher=org.apache.solr.common.cloud.ConnectionManager@1908d71
[junit4:junit4] 2> 8604 T2733 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 8606 T2786 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server 127.0.0.1/127.0.0.1:59481. Will not attempt to authenticate using SASL (access denied ("javax.security.auth.AuthPermission" "getLoginConfiguration"))
[junit4:junit4] 2> 8607 T2786 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to 127.0.0.1/127.0.0.1:59481, initiating session
[junit4:junit4] 2> 8607 T2735 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:59514
[junit4:junit4] 2> 8607 T2735 oazs.ZooKeeperServer.processConnectRequest Client attempting to establish new session at /127.0.0.1:59514
[junit4:junit4] 2> 8620 T2737 oazs.ZooKeeperServer.finishSessionInit Established session 0x13c7aba11220007 with negotiated timeout 20000 for client /127.0.0.1:59514
[junit4:junit4] 2> 8620 T2786 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server 127.0.0.1/127.0.0.1:59481, sessionid = 0x13c7aba11220007, negotiated timeout = 20000
[junit4:junit4] 2> 8620 T2787 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1908d71 name:ZooKeeperConnection Watcher:127.0.0.1:59481 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 8620 T2733 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 8621 T2738 oazs.PrepRequestProcessor.pRequest2Txn Processed session termination for sessionid: 0x13c7aba11220007
[junit4:junit4] 2> 8623 T2733 oaz.ZooKeeper.close Session: 0x13c7aba11220007 closed
[junit4:junit4] 2> 8623 T2733 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=500&maxConnectionsPerHost=16&socketTimeout=60000&connTimeout=15000
[junit4:junit4] 2> 8623 T2735 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:59514 which had sessionid 0x13c7aba11220007
[junit4:junit4] 2> 8624 T2787 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4] 2> 8631 T2733 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:59481/solr sessionTimeout=30000 watcher=org.apache.solr.common.cloud.ConnectionManager@18ef3b7
[junit4:junit4] 2> 8634 T2733 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 8635 T2788 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server 127.0.0.1/127.0.0.1:59481. Will not attempt to authenticate using SASL (access denied ("javax.security.auth.AuthPermission" "getLoginConfiguration"))
[junit4:junit4] 2> 8637 T2788 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to 127.0.0.1/127.0.0.1:59481, initiating session
[junit4:junit4] 2> 8637 T2735 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:59517
[junit4:junit4] 2> 8637 T2735 oazs.ZooKeeperServer.processConnectRequest Client attempting to establish new session at /127.0.0.1:59517
[junit4:junit4] 2> 8639 T2737 oazs.ZooKeeperServer.finishSessionInit Established session 0x13c7aba11220008 with negotiated timeout 20000 for client /127.0.0.1:59517
[junit4:junit4] 2> 8639 T2788 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server 127.0.0.1/127.0.0.1:59481, sessionid = 0x13c7aba11220008, negotiated timeout = 20000
[junit4:junit4] 2> 8640 T2789 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@18ef3b7 name:ZooKeeperConnection Watcher:127.0.0.1:59481/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 8640 T2733 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 8641 T2738 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c7aba11220008 type:create cxid:0x1 zxid:0x6d txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4] 2> 8644 T2738 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c7aba11220008 type:create cxid:0x2 zxid:0x6e txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4] 2> 8647 T2733 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59509_y_%2Fn
[junit4:junit4] 2> 8648 T2738 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c7aba11220008 type:delete cxid:0x4 zxid:0x6f txntype:-1 reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:59509_y_%2Fn Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:59509_y_%2Fn
[junit4:junit4] 2> 8651 T2733 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:59509_y_%2Fn
[junit4:junit4] 2> 8657 T2774 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> 8658 T2761 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> 8658 T2755 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> 8662 T2774 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4] 2> 8665 T2761 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4] 2> 8665 T2755 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4] 2> 8667 T2733 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4:junit4] 2> 8675 T2790 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-1359268688091\collection1
[junit4:junit4] 2> 8676 T2790 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4] 2> 8676 T2790 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4] 2> 8676 T2790 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4] 2> 8679 T2790 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-1359268688091\collection1\'
[junit4:junit4] 2> 8680 T2790 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-1359268688091/collection1/lib/classes/' to classloader
[junit4:junit4] 2> 8681 T2790 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-1359268688091/collection1/lib/README' to classloader
[junit4:junit4] 2> 8742 T2790 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4] 2> 8837 T2790 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4] 2> 8840 T2790 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4] 2> 8845 T2790 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4] 2> 9607 T2790 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4] 2> 9618 T2790 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4] 2> 9622 T2790 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4] 2> 9643 T2790 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 9648 T2790 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 9655 T2790 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 9656 T2790 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 9658 T2790 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-1359268688091\collection1\, dataDir=.\org.apache.solr.cloud.RecoveryZkTest-1359268679961/jetty2\
[junit4:junit4] 2> 9658 T2790 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1b04fbf
[junit4:junit4] 2> 9659 T2790 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4] 2> 9659 T2790 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-1359268679961\jetty2 forceNew:false
[junit4:junit4] 2> 9659 T2790 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1359268679961\jetty2
[junit4:junit4] 2> 9660 T2790 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=.\org.apache.solr.cloud.RecoveryZkTest-1359268679961/jetty2\index/
[junit4:junit4] 2> 9661 T2790 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '.\org.apache.solr.cloud.RecoveryZkTest-1359268679961\jetty2\index' doesn't exist. Creating new index...
[junit4:junit4] 2> 9661 T2790 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-1359268679961\jetty2\index forceNew:false
[junit4:junit4] 2> 9666 T2790 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@536da9 lockFactory=org.apache.lucene.store.NativeFSLockFactory@16fc003)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> 9666 T2790 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4] 2> 9668 T2790 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1359268679961\jetty2\index
[junit4:junit4] 2> 9668 T2790 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4] 2> 9671 T2790 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4] 2> 9671 T2790 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4] 2> 9672 T2790 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4] 2> 9672 T2790 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4] 2> 9672 T2790 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4] 2> 9673 T2790 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4] 2> 9673 T2790 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4] 2> 9673 T2790 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4] 2> 9674 T2790 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4] 2> 9674 T2790 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4] 2> 9675 T2790 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4] 2> 9675 T2790 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4] 2> 9676 T2790 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4] 2> 9676 T2790 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4] 2> 9676 T2790 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4] 2> 9676 T2790 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4] 2> 9677 T2790 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 9677 T2790 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 9678 T2790 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 9678 T2790 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 9678 T2790 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 9679 T2790 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 9679 T2790 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 9680 T2790 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 9680 T2790 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4] 2> 9681 T2790 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4] 2> 9692 T2790 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4] 2> 9697 T2790 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4] 2> 9699 T2790 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> 9699 T2756 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 9701 T2756 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:59500_y_%2Fn",
[junit4:junit4] 2> "base_url":"http://127.0.0.1:59500/y_/n"}
[junit4:junit4] 2> 9701 T2790 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1359268679961\jetty2
[junit4:junit4] 2> 9702 T2790 oass.SolrIndexSearcher.<init> Opening Searcher@195b63c main
[junit4:junit4] 2> 9704 T2790 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4] 2> 9704 T2790 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4] 2> 9704 T2790 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4] 2> 9717 T2774 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> 9717 T2761 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> 9718 T2755 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> 9718 T2789 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> 9722 T2790 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4] 2> 9783 T2791 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@195b63c main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4] 2> 9787 T2790 oasc.ZkController.publish publishing core=collection1 state=down
[junit4:junit4] 2> 9788 T2790 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4] 2> 11346 T2756 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 11347 T2756 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:59509_y_%2Fn",
[junit4:junit4] 2> "base_url":"http://127.0.0.1:59509/y_/n"}
[junit4:junit4] 2> 11348 T2756 oasc.Overseer$ClusterStateUpdater.updateState Collection already exists with numShards=1
[junit4:junit4] 2> 11348 T2756 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1
[junit4:junit4] 2> 11373 T2774 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> 11374 T2789 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> 11374 T2761 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> 11376 T2755 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> 11947 T2790 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4] 2> 11947 T2790 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:59509/y_/n collection:collection1 shard:shard1
[junit4:junit4] 2> 11952 T2790 oasc.ZkController.register We are http://127.0.0.1:59509/y_/n/collection1/ and leader is http://127.0.0.1:59500/y_/n/collection1/
[junit4:junit4] 2> 11952 T2790 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:59509/y_/n
[junit4:junit4] 2> 11952 T2790 oasc.ZkController.checkRecovery Core needs to recover:collection1
[junit4:junit4] 2> 11953 T2790 oasu.DefaultSolrCoreState.doRecovery Running recovery - first canceling any ongoing recovery
[junit4:junit4] 2> ASYNC NEW_CORE C198 name=collection1 org.apache.solr.core.SolrCore@124db1d url=http://127.0.0.1:59509/y_/n/collection1 node=127.0.0.1:59509_y_%2Fn C198_STATE=coll:collection1 core:collection1 props:{shard=null, roles=null, state=down, core=collection1, collection=collection1, node_name=127.0.0.1:59509_y_%2Fn, base_url=http://127.0.0.1:59509/y_/n}
[junit4:junit4] 2> 11960 T2792 C198 P59509 oasc.RecoveryStrategy.run Starting recovery process. core=collection1 recoveringAfterStartup=true
[junit4:junit4] 2> 11961 T2792 C198 P59509 oasc.RecoveryStrategy.doRecovery ###### startupVersions=[]
[junit4:junit4] 2> 11961 T2790 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 11961 T2792 C198 P59509 oasc.ZkController.publish publishing core=collection1 state=recovering
[junit4:junit4] 2> 11961 T2792 C198 P59509 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4] 2> 11963 T2733 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4:junit4] 2> 11964 T2733 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4] 2> 11964 T2792 C198 P59509 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 2> 11964 T2733 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 2> 11974 T2733 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> ASYNC NEW_CORE C199 name=collection1 org.apache.solr.core.SolrCore@bfc697 url=http://127.0.0.1:59488/y_/n/collection1 node=127.0.0.1:59488_y_%2Fn C199_STATE=coll:control_collection core:collection1 props:{shard=shard1, roles=null, state=active, core=collection1, collection=control_collection, node_name=127.0.0.1:59488_y_%2Fn, base_url=http://127.0.0.1:59488/y_/n, leader=true}
[junit4:junit4] 2> 11993 T2747 C199 P59488 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1359268679961\control\data
[junit4:junit4] 2> 11997 T2747 C199 P59488 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@1083941 lockFactory=org.apache.lucene.store.NativeFSLockFactory@ddd7f6)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> 11998 T2747 C199 P59488 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4] 2> 12001 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[10001 (1425296527927017472)]} 0 10
[junit4:junit4] 2> 12001 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[1 (1425296527927017473)]} 0 10
[junit4:junit4] 2> ASYNC NEW_CORE C200 name=collection1 org.apache.solr.core.SolrCore@1b4f26c url=http://127.0.0.1:59500/y_/n/collection1 node=127.0.0.1:59500_y_%2Fn C200_STATE=coll:collection1 core:collection1 props:{shard=shard1, roles=null, state=active, core=collection1, collection=collection1, node_name=127.0.0.1:59500_y_%2Fn, base_url=http://127.0.0.1:59500/y_/n, leader=true}
[junit4:junit4] 2> 12014 T2767 C200 P59500 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1359268679961\jetty1
[junit4:junit4] 2> 12020 T2767 C200 P59500 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@10634d0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1b55a63)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> 12021 T2767 C200 P59500 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4] 2> 12025 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[10001 (1425296527951134720)]} 0 11
[junit4:junit4] 2> 12025 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[1 (1425296527950086144)]} 0 13
[junit4:junit4] 2> 12029 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[10002 (1425296527965814784)]} 0 1
[junit4:junit4] 2> 12029 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[2 (1425296527965814785)]} 0 1
[junit4:junit4] 2> 12031 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10002 (1425296527968960512)]} 0 0
[junit4:junit4] 2> 12034 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[2 (1425296527972106240)]} 0 1
[junit4:junit4] 2> 12035 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[10003 (1425296527973154816)]} 0 0
[junit4:junit4] 2> 12037 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[3 (1425296527975251968)]} 0 0
[junit4:junit4] 2> 12039 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[10003 (1425296527977349120)]} 0 0
[junit4:junit4] 2> 12041 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[3 (1425296527979446272)]} 0 0
[junit4:junit4] 2> 12043 T2746 C199 P59488 /update {wt=javabin&version=2} {delete=[10002 (-1425296527981543424)]} 0 0
[junit4:junit4] 2> 12046 T2747 C199 P59488 /update {wt=javabin&version=2} {delete=[2 (-1425296527983640576)]} 0 1
[junit4:junit4] 2> 12046 T2768 C200 P59500 /update {wt=javabin&version=2} {delete=[10002 (-1425296527984689152)]} 0 0
[junit4:junit4] 2> 12049 T2769 C200 P59500 /update {wt=javabin&version=2} {delete=[2 (-1425296527986786304)]} 0 1
[junit4:junit4] 2> 12050 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[10004 (1425296527987834880)]} 0 1
[junit4:junit4] 2> 12053 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[4 (1425296527992029184)]} 0 0
[junit4:junit4] 2> 12053 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[10004 (1425296527992029184)]} 0 0
[junit4:junit4] 2> 12056 T2750 C199 P59488 /update {wt=javabin&version=2} {delete=[10003 (-1425296527995174912)]} 0 0
[junit4:junit4] 2> 12057 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[4 (1425296527995174912)]} 0 1
[junit4:junit4] 2> 12059 T2767 C200 P59500 /update {wt=javabin&version=2} {delete=[10003 (-1425296527998320640)]} 0 0
[junit4:junit4] 2> 12059 T2751 C199 P59488 /update {wt=javabin&version=2} {delete=[3 (-1425296527998320640)]} 0 0
[junit4:junit4] 2> 12064 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[10005 (1425296528002514944)]} 0 1
[junit4:junit4] 2> 12064 T2768 C200 P59500 /update {wt=javabin&version=2} {delete=[3 (-1425296528003563520)]} 0 0
[junit4:junit4] 2> 12067 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10005 (1425296528005660672)]} 0 1
[junit4:junit4] 2> 12069 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[5 (1425296528006709248)]} 0 2
[junit4:junit4] 2> 12072 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[10006 (1425296528010903552)]} 0 1
[junit4:junit4] 2> 12076 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[5 (1425296528013000704)]} 0 3
[junit4:junit4] 2> 12076 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[10006 (1425296528015097856)]} 0 1
[junit4:junit4] 2> 12079 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[6 (1425296528019292160)]} 0 1
[junit4:junit4] 2> 12081 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[10007 (1425296528020340736)]} 0 1
[junit4:junit4] 2> 12084 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[6 (1425296528024535040)]} 0 0
[junit4:junit4] 2> 12086 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10007 (1425296528026632192)]} 0 1
[junit4:junit4] 2> 12088 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[7 (1425296528027680768)]} 0 1
[junit4:junit4] 2> 12088 T2746 C199 P59488 /update {wt=javabin&version=2} {delete=[10005 (-1425296528028729344)]} 0 0
[junit4:junit4] 2> 12091 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[7 (1425296528031875072)]} 0 1
[junit4:junit4] 2> 12091 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[10005 (-1425296528031875073)]} 0 0
[junit4:junit4] 2> 12095 T2747 C199 P59488 /update {wt=javabin&version=2} {delete=[5 (-1425296528036069376)]} 0 0
[junit4:junit4] 2> 12096 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[10008 (1425296528036069377)]} 0 1
[junit4:junit4] 2> 12099 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[5 (-1425296528040263680)]} 0 1
[junit4:junit4] 2> 12100 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[10008 (1425296528040263681)]} 0 1
[junit4:junit4] 2> 12101 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[8 (1425296528042360832)]} 0 0
[junit4:junit4] 2> 12104 T2750 C199 P59488 /update {wt=javabin&version=2} {delete=[10006 (-1425296528045506560)]} 0 0
[junit4:junit4] 2> 12109 T2767 C200 P59500 /update {wt=javabin&version=2} {delete=[10006 (-1425296528050749440)]} 0 1
[junit4:junit4] 2> 12111 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[8 (1425296528051798016)]} 0 1
[junit4:junit4] 2> 12113 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[10009 (1425296528054943744)]} 0 0
[junit4:junit4] 2> 12117 T2746 C199 P59488 /update {wt=javabin&version=2} {delete=[6 (-1425296528059138048)]} 0 0
[junit4:junit4] 2> 12119 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10009 (1425296528061235200)]} 0 0
[junit4:junit4] 2> 12123 T2747 C199 P59488 /update {wt=javabin&version=2} {delete=[10007 (-1425296528065429504)]} 0 0
[junit4:junit4] 2> 12125 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[6 (-1425296528067526656)]} 0 0
[junit4:junit4] 2> 12127 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[9 (1425296528069623808)]} 0 0
[junit4:junit4] 2> 12128 T2768 C200 P59500 /update {wt=javabin&version=2} {delete=[10007 (-1425296528070672384)]} 0 0
[junit4:junit4] 2> 12130 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[9 (1425296528072769536)]} 0 0
[junit4:junit4] 2> 12134 T2750 C199 P59488 /update {wt=javabin&version=2} {delete=[7 (-1425296528076963840)]} 0 0
[junit4:junit4] 2> 12135 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[10010 (1425296528076963841)]} 0 1
[junit4:junit4] 2> 12145 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[7 (-1425296528088498176)]} 0 0
[junit4:junit4] 2> 12147 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10010 (1425296528089546752)]} 0 1
[junit4:junit4] 2> 12150 T2746 C199 P59488 /update {wt=javabin&version=2} {delete=[10009 (-1425296528093741056)]} 0 0
[junit4:junit4] 2> 12152 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[10 (1425296528091643904)]} 0 4
[junit4:junit4] 2> 12154 T2768 C200 P59500 /update {wt=javabin&version=2} {delete=[10009 (-1425296528097935361)]} 0 0
[junit4:junit4] 2> 12157 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[10 (1425296528097935360)]} 0 3
[junit4:junit4] 2> 12158 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[10011 (1425296528101081088)]} 0 1
[junit4:junit4] 2> 12159 T2748 C199 P59488 /update {wt=javabin&version=2} {delete=[9 (-1425296528103178240)]} 0 0
[junit4:junit4] 2> 12160 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10011 (1425296528104226816)]} 0 0
[junit4:junit4] 2> 12163 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[9 (-1425296528107372544)]} 0 0
[junit4:junit4] 2> 12165 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[10012 (1425296528109469696)]} 0 0
[junit4:junit4] 2> 12167 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[11 (1425296528110518272)]} 0 1
[junit4:junit4] 2> 12169 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[10012 (1425296528112615424)]} 0 1
[junit4:junit4] 2> 12169 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[11 (1425296528113664000)]} 0 0
[junit4:junit4] 2> 12171 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[10013 (1425296528115761152)]} 0 0
[junit4:junit4] 2> 12172 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[12 (1425296528116809728)]} 0 0
[junit4:junit4] 2> 12174 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10013 (1425296528118906880)]} 0 0
[junit4:junit4] 2> 12176 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[12 (1425296528121004032)]} 0 0
[junit4:junit4] 2> 12177 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[10014 (1425296528122052608)]} 0 0
[junit4:junit4] 2> 12179 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[13 (1425296528124149760)]} 0 0
[junit4:junit4] 2> 12183 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[10014 (1425296528126246912)]} 0 2
[junit4:junit4] 2> 12183 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[13 (1425296528128344064)]} 0 0
[junit4:junit4] 2> 12185 T2750 C199 P59488 /update {wt=javabin&version=2} {delete=[10014 (-1425296528130441216)]} 0 0
[junit4:junit4] 2> 12187 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[14 (1425296528132538368)]} 0 0
[junit4:junit4] 2> 12188 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[10014 (-1425296528133586944)]} 0 0
[junit4:junit4] 2> 12190 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[14 (1425296528135684096)]} 0 0
[junit4:junit4] 2> 12192 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[10015 (1425296528137781248)]} 0 0
[junit4:junit4] 2> 12195 T2751 C199 P59488 /update {wt=javabin&version=2} {delete=[14 (-1425296528140926976)]} 0 1
[junit4:junit4] 2> 12196 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10015 (1425296528140926976)]} 0 1
[junit4:junit4] 2> 12197 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[14 (-1425296528143024128)]} 0 0
[junit4:junit4] 2> 12200 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[10016 (1425296528144072704)]} 0 2
[junit4:junit4] 2> 12201 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[15 (1425296528146169856)]} 0 1
[junit4:junit4] 2> 12205 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[15 (1425296528150364161)]} 0 1
[junit4:junit4] 2> 12206 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[10016 (1425296528150364160)]} 0 2
[junit4:junit4] 2> 12208 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[16 (1425296528153509888)]} 0 1
[junit4:junit4] 2> 12210 T2746 C199 P59488 /update {wt=javabin&version=2} {delete=[10016 (-1425296528156655616)]} 0 0
[junit4:junit4] 2> 12210 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[16 (1425296528156655616)]} 0 0
[junit4:junit4] 2> 12212 T2769 C200 P59500 /update {wt=javabin&version=2} {delete=[10016 (-1425296528158752768)]} 0 0
[junit4:junit4] 2> 12213 T2751 C199 P59488 /update {wt=javabin&version=2} {delete=[16 (-1425296528159801344)]} 0 0
[junit4:junit4] 2> 12216 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[10017 (1425296528161898496)]} 0 1
[junit4:junit4] 2> 12216 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[16 (-1425296528162947072)]} 0 0
[junit4:junit4] 2> 12218 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[10017 (1425296528165044224)]} 0 0
[junit4:junit4] 2> 12219 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[17 (1425296528166092800)]} 0 0
[junit4:junit4] 2> 12223 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[10018 (1425296528169238528)]} 0 1
[junit4:junit4] 2> 12223 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[17 (1425296528170287104)]} 0 0
[junit4:junit4] 2> 12225 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10018 (1425296528172384256)]} 0 0
[junit4:junit4] 2> 12226 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[18 (1425296528173432832)]} 0 0
[junit4:junit4] 2> 12228 T2746 C199 P59488 /update {wt=javabin&version=2} {delete=[10018 (-1425296528175529984)]} 0 0
[junit4:junit4] 2> 12230 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[18 (1425296528177627136)]} 0 0
[junit4:junit4] 2> 12231 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[10018 (-1425296528178675712)]} 0 0
[junit4:junit4] 2> 12233 T2751 C199 P59488 /update {wt=javabin&version=2} {delete=[18 (-1425296528180772864)]} 0 0
[junit4:junit4] 2> 12234 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[10019 (1425296528181821440)]} 0 0
[junit4:junit4] 2> 12236 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[18 (-1425296528183918592)]} 0 0
[junit4:junit4] 2> 12237 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[10019 (1425296528184967168)]} 0 0
[junit4:junit4] 2> 12239 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[19 (1425296528187064320)]} 0 0
[junit4:junit4] 2> 12242 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[10020 (1425296528190210048)]} 0 0
[junit4:junit4] 2> 12244 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[19 (1425296528192307200)]} 0 0
[junit4:junit4] 2> 12245 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10020 (1425296528193355776)]} 0 0
[junit4:junit4] 2> 12248 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[10021 (1425296528196501504)]} 0 0
[junit4:junit4] 2> 12249 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[20 (1425296528195452928)]} 0 2
[junit4:junit4] 2> 12253 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[20 (1425296528200695808)]} 0 1
[junit4:junit4] 2> 12253 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[10021 (1425296528199647232)]} 0 2
[junit4:junit4] 2> 12257 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[10022 (1425296528204890112)]} 0 1
[junit4:junit4] 2> 12257 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[21 (1425296528204890113)]} 0 1
[junit4:junit4] 2> 12264 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[21 (1425296528212230144)]} 0 1
[junit4:junit4] 2> 12264 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10022 (1425296528212230145)]} 0 1
[junit4:junit4] 2> 12266 T2747 C199 P59488 /update {wt=javabin&version=2} {delete=[10020 (-1425296528215375872)]} 0 0
[junit4:junit4] 2> 12266 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[22 (1425296528215375873)]} 0 0
[junit4:junit4] 2> 12268 T2767 C200 P59500 /update {wt=javabin&version=2} {delete=[10020 (-1425296528217473024)]} 0 0
[junit4:junit4] 2> 12271 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[22 (1425296528220618752)]} 0 0
[junit4:junit4] 2> 12271 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[10023 (1425296528220618752)]} 0 0
[junit4:junit4] 2> 12278 T2749 C199 P59488 /update {wt=javabin&version=2} {delete=[20 (-1425296528227958784)]} 0 0
[junit4:junit4] 2> 12278 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[10023 (1425296528227958784)]} 0 0
[junit4:junit4] 2> 12284 T2768 C200 P59500 /update {wt=javabin&version=2} {delete=[20 (-1425296528234250240)]} 0 0
[junit4:junit4] 2> 12284 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[10024 (1425296528234250240)]} 0 0
[junit4:junit4] 2> 12287 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10024 (1425296528237395968)]} 0 0
[junit4:junit4] 2> 12287 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[23 (1425296528237395968)]} 0 0
[junit4:junit4] 2> 12291 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[10025 (1425296528240541696)]} 0 1
[junit4:junit4] 2> 12291 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[23 (1425296528240541696)]} 0 1
[junit4:junit4] 2> 12294 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[10025 (1425296528244736000)]} 0 0
[junit4:junit4] 2> 12294 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[24 (1425296528244736000)]} 0 0
[junit4:junit4] 2> 12297 T2746 C199 P59488 /update {wt=javabin&version=2} {delete=[10023 (-1425296528247881728)]} 0 0
[junit4:junit4] 2> 12297 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[24 (1425296528247881728)]} 0 0
[junit4:junit4] 2> 12302 T2768 C200 P59500 /update {wt=javabin&version=2} {delete=[10023 (-1425296528253124608)]} 0 0
[junit4:junit4] 2> 12304 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[25 (1425296528253124608)]} 0 2
[junit4:junit4] 2> 12306 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[10026 (1425296528256270336)]} 0 1
[junit4:junit4] 2> 12309 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[25 (1425296528258367488)]} 0 2
[junit4:junit4] 2> 12310 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10026 (1425296528260464640)]} 0 1
[junit4:junit4] 2> 12319 T2751 C199 P59488 /update {wt=javabin&version=2} {delete=[23 (-1425296528269901824)]} 0 1
[junit4:junit4] 2> 12320 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[10027 (1425296528271998976)]} 0 0
[junit4:junit4] 2> 12322 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[23 (-1425296528274096128)]} 0 0
[junit4:junit4] 2> 12324 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[10027 (1425296528276193280)]} 0 0
[junit4:junit4] 2> 12326 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[26 (1425296528278290432)]} 0 0
[junit4:junit4] 2> 12327 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[10028 (1425296528279339008)]} 0 0
[junit4:junit4] 2> 12329 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[26 (1425296528281436160)]} 0 0
[junit4:junit4] 2> 12330 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[10028 (1425296528282484736)]} 0 0
[junit4:junit4] 2> 12332 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[27 (1425296528284581888)]} 0 0
[junit4:junit4] 2> 12333 T2748 C199 P59488 /update {wt=javabin&version=2} {delete=[10028 (-1425296528285630464)]} 0 0
[junit4:junit4] 2> 12336 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[27 (1425296528288776192)]} 0 0
[junit4:junit4] 2> 12336 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[10028 (-1425296528288776193)]} 0 0
[junit4:junit4] 2> 12340 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[10029 (1425296528291921920)]} 0 1
[junit4:junit4] 2> 12340 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[28 (1425296528291921921)]} 0 1
[junit4:junit4] 2> 12343 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[10029 (1425296528296116224)]} 0 0
[junit4:junit4] 2> 12344 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[28 (1425296528296116225)]} 0 1
[junit4:junit4] 2> 12346 T2746 C199 P59488 /update {wt=javabin&version=2} {delete=[28 (-1425296528299261953)]} 0 0
[junit4:junit4] 2> 12346 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[10030 (1425296528299261952)]} 0 0
[junit4:junit4] 2> 12349 T2767 C200 P59500 /update {wt=javabin&version=2} {delete=[28 (-1425296528302407680)]} 0 0
[junit4:junit4] 2> 12349 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[10030 (1425296528302407681)]} 0 0
[junit4:junit4] 2> 12352 T2749 C199 P59488 /update {wt=javabin&version=2} {delete=[10030 (-1425296528305553408)]} 0 0
[junit4:junit4] 2> 12353 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[29 (1425296528305553409)]} 0 1
[junit4:junit4] 2> 12355 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[10030 (-1425296528308699136)]} 0 0
[junit4:junit4] 2> 12355 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[29 (1425296528308699137)]} 0 0
[junit4:junit4] 2> 12359 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[30 (1425296528311844865)]} 0 1
[junit4:junit4] 2> 12362 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[10031 (1425296528311844864)]} 0 4
[junit4:junit4] 2> 12366 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[10031 (1425296528319184896)]} 0 1
[junit4:junit4] 2> 12368 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[30 (1425296528318136320)]} 0 4
[junit4:junit4] 2> 12370 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[10032 (1425296528323379200)]} 0 1
[junit4:junit4] 2> 12371 T2746 C199 P59488 /update {wt=javabin&version=2} {delete=[30 (-1425296528325476352)]} 0 0
[junit4:junit4] 2> 12373 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10032 (1425296528327573504)]} 0 0
[junit4:junit4] 2> 12374 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[30 (-1425296528328622080)]} 0 0
[junit4:junit4] 2> 12376 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[10033 (1425296528330719232)]} 0 0
[junit4:junit4] 2> 12377 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[31 (1425296528331767808)]} 0 0
[junit4:junit4] 2> 12380 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[10033 (1425296528333864960)]} 0 1
[junit4:junit4] 2> 12380 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[31 (1425296528334913536)]} 0 0
[junit4:junit4] 2> 12384 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[10034 (1425296528338059264)]} 0 1
[junit4:junit4] 2> 12385 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[32 (1425296528340156416)]} 0 0
[junit4:junit4] 2> 12386 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10034 (1425296528341204992)]} 0 0
[junit4:junit4] 2> 12388 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[32 (1425296528343302144)]} 0 0
[junit4:junit4] 2> 12390 T2750 C199 P59488 /update {wt=javabin&version=2} {delete=[10034 (-1425296528345399296)]} 0 0
[junit4:junit4] 2> 12392 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[10034 (-1425296528347496448)]} 0 0
[junit4:junit4] 2> 12392 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[33 (1425296528347496448)]} 0 0
[junit4:junit4] 2> 12395 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[10035 (1425296528350642176)]} 0 0
[junit4:junit4] 2> 12395 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[33 (1425296528350642176)]} 0 0
[junit4:junit4] 2> 12398 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[10035 (1425296528353787904)]} 0 0
[junit4:junit4] 2> 12398 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[34 (1425296528353787904)]} 0 0
[junit4:junit4] 2> 12402 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[34 (1425296528357982208)]} 0 0
[junit4:junit4] 2> 12404 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[10036 (1425296528357982208)]} 0 2
[junit4:junit4] 2> 12405 T2751 C199 P59488 /update {wt=javabin&version=2} {delete=[34 (-1425296528361127936)]} 0 0
[junit4:junit4] 2> 12408 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[34 (-1425296528364273665)]} 0 0
[junit4:junit4] 2> 12410 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10036 (1425296528364273664)]} 0 2
[junit4:junit4] 2> 12411 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[35 (1425296528366370816)]} 0 1
[junit4:junit4] 2> 12412 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[10037 (1425296528368467968)]} 0 0
[junit4:junit4] 2> 12414 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[35 (1425296528369516544)]} 0 1
[junit4:junit4] 2> 12415 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[10037 (1425296528371613696)]} 0 0
[junit4:junit4] 2> 12417 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[36 (1425296528372662272)]} 0 1
[junit4:junit4] 2> 12418 T2748 C199 P59488 /update {wt=javabin&version=2} {delete=[10037 (-1425296528374759424)]} 0 0
[junit4:junit4] 2> 12419 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[36 (1425296528375808000)]} 0 0
[junit4:junit4] 2> 12424 T2769 C200 P59500 /update {wt=javabin&version=2} {delete=[10037 (-1425296528378953728)]} 0 2
[junit4:junit4] 2> 12425 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[37 (1425296528382099456)]} 0 0
[junit4:junit4] 2> 12427 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[10038 (1425296528384196608)]} 0 1
[junit4:junit4] 2> 12429 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[37 (1425296528386293760)]} 0 1
[junit4:junit4] 2> 12431 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10038 (1425296528387342336)]} 0 1
[junit4:junit4] 2> 12432 T2750 C199 P59488 /update {wt=javabin&version=2} {delete=[37 (-1425296528389439488)]} 0 0
[junit4:junit4] 2> 12433 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[10039 (1425296528390488064)]} 0 0
[junit4:junit4] 2> 12436 T2768 C200 P59500 /update {wt=javabin&version=2} {delete=[37 (-1425296528393633792)]} 0 0
[junit4:junit4] 2> 12436 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[10039 (1425296528393633793)]} 0 0
[junit4:junit4] 2> 12439 T2749 C199 P59488 /update {wt=javabin&version=2} {delete=[10038 (-1425296528396779520)]} 0 0
[junit4:junit4] 2> 12439 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[38 (1425296528396779521)]} 0 0
[junit4:junit4] 2> 12443 T2769 C200 P59500 /update {wt=javabin&version=2} {delete=[10038 (-1425296528400973824)]} 0 0
[junit4:junit4] 2> 12444 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[38 (1425296528400973825)]} 0 1
[junit4:junit4] 2> 12446 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[39 (1425296528404119552)]} 0 0
[junit4:junit4] 2> 12446 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[10040 (1425296528404119553)]} 0 0
[junit4:junit4] 2> 12450 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[10040 (1425296528408313856)]} 0 0
[junit4:junit4] 2> 12450 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[39 (1425296528408313857)]} 0 0
[junit4:junit4] 2> 12453 T2746 C199 P59488 /update {wt=javabin&version=2} {delete=[38 (-1425296528411459585)]} 0 0
[junit4:junit4] 2> 12456 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[10041 (1425296528411459584)]} 0 3
[junit4:junit4] 2> 12457 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[38 (-1425296528415653888)]} 0 0
[junit4:junit4] 2> 12462 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[40 (1425296528420896768)]} 0 2
[junit4:junit4] 2> 12463 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10041 (1425296528416702464)]} 0 5
[junit4:junit4] 2> 12473 T2748 C199 P59488 /update {wt=javabin&version=2} {delete=[10039 (-1425296528432431104)]} 0 0
[junit4:junit4] 2> 12475 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[40 (1425296528424042496)]} 0 10
[junit4:junit4] 2> 12476 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[10039 (-1425296528435576832)]} 0 0
[junit4:junit4] 2> 12478 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[41 (1425296528436625408)]} 0 1
[junit4:junit4] 2> 12482 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[10042 (1425296528439771136)]} 0 2
[junit4:junit4] 2> 12482 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[41 (1425296528439771136)]} 0 2
[junit4:junit4] 2> 12484 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[10042 (1425296528443965440)]} 0 0
[junit4:junit4] 2> 12486 T2746 C199 P59488 /update {wt=javabin&version=2} {delete=[39 (-1425296528446062592)]} 0 0
[junit4:junit4] 2> 12487 T2746 C199 P59488 /update {wt=javabin&version=2} {delete=[10042 (-1425296528447111168)]} 0 0
[junit4:junit4] 2> 12490 T2769 C200 P59500 /update {wt=javabin&version=2} {delete=[39 (-1425296528450256896)]} 0 1
[junit4:junit4] 2> 12491 T2769 C200 P59500 /update {wt=javabin&version=2} {delete=[10042 (-1425296528451305472)]} 0 0
[junit4:junit4] 2> 12494 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[42 (1425296528453402624)]} 0 1
[junit4:junit4] 2> 12495 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[10043 (1425296528455499776)]} 0 0
[junit4:junit4] 2> 12498 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[42 (1425296528457596928)]} 0 1
[junit4:junit4] 2> 12499 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[10043 (1425296528458645504)]} 0 1
[junit4:junit4] 2> 12500 T2747 C199 P59488 /update {wt=javabin&version=2} {delete=[42 (-1425296528460742656)]} 0 0
[junit4:junit4] 2> 12502 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[10044 (1425296528462839808)]} 0 0
[junit4:junit4] 2> 12504 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[42 (-1425296528464936960)]} 0 0
[junit4:junit4] 2> 12506 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10044 (1425296528467034112)]} 0 0
[junit4:junit4] 2> 12508 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[43 (1425296528468082688)]} 0 1
[junit4:junit4] 2> 12509 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[10045 (1425296528470179840)]} 0 0
[junit4:junit4] 2> 12510 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[43 (1425296528471228416)]} 0 0
[junit4:junit4] 2> 12512 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[10045 (1425296528473325568)]} 0 0
[junit4:junit4] 2> 12513 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[44 (1425296528474374144)]} 0 0
[junit4:junit4] 2> 12515 T2748 C199 P59488 /update {wt=javabin&version=2} {delete=[10044 (-1425296528476471296)]} 0 0
[junit4:junit4] 2> 12517 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[44 (1425296528477519872)]} 0 1
[junit4:junit4] 2> 12518 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[10044 (-1425296528479617024)]} 0 0
[junit4:junit4] 2> 12522 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[45 (1425296528480665600)]} 0 3
[junit4:junit4] 2> 12523 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[10046 (1425296528483811328)]} 0 1
[junit4:junit4] 2> 12526 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[45 (1425296528486957057)]} 0 1
[junit4:junit4] 2> 12527 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10046 (1425296528486957056)]} 0 2
[junit4:junit4] 2> 12528 T2746 C199 P59488 /update {wt=javabin&version=2} {delete=[44 (-1425296528490102784)]} 0 0
[junit4:junit4] 2> 12530 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[10047 (1425296528492199936)]} 0 0
[junit4:junit4] 2> 12531 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[44 (-1425296528493248512)]} 0 0
[junit4:junit4] 2> 12533 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[10047 (1425296528495345664)]} 0 0
[junit4:junit4] 2> 12535 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[46 (1425296528496394240)]} 0 1
[junit4:junit4] 2> 12536 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[10048 (1425296528498491392)]} 0 0
[junit4:junit4] 2> 12538 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[46 (1425296528500588544)]} 0 0
[junit4:junit4] 2> 12541 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10048 (1425296528503734272)]} 0 0
[junit4:junit4] 2> 12543 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[47 (1425296528504782848)]} 0 1
[junit4:junit4] 2> 12544 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[10049 (1425296528506880000)]} 0 0
[junit4:junit4] 2> 12545 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[47 (1425296528507928576)]} 0 0
[junit4:junit4] 2> 12547 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[10049 (1425296528510025728)]} 0 0
[junit4:junit4] 2> 12548 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[48 (1425296528511074304)]} 0 0
[junit4:junit4] 2> 12550 T2750 C199 P59488 /update {wt=javabin&version=2} {delete=[10049 (-1425296528513171456)]} 0 0
[junit4:junit4] 2> 12551 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[48 (1425296528514220032)]} 0 0
[junit4:junit4] 2> 12553 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[10049 (-1425296528516317184)]} 0 0
[junit4:junit4] 2> 12555 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[49 (1425296528518414336)]} 0 0
[junit4:junit4] 2> 12558 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[10050 (1425296528520511488)]} 0 1
[junit4:junit4] 2> 12558 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[49 (1425296528521560064)]} 0 0
[junit4:junit4] 2> 12562 T2747 C199 P59488 /update {wt=javabin&version=2} {delete=[49 (-1425296528525754368)]} 0 0
[junit4:junit4] 2> 12562 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10050 (1425296528525754368)]} 0 0
[junit4:junit4] 2> 12565 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[49 (-1425296528528900096)]} 0 0
[junit4:junit4] 2> 12567 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[10051 (1425296528528900096)]} 0 2
[junit4:junit4] 2> 12568 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[50 (1425296528532045824)]} 0 0
[junit4:junit4] 2> 12572 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[10051 (1425296528534142976)]} 0 2
[junit4:junit4] 2> 12573 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[50 (1425296528536240128)]} 0 1
[junit4:junit4] 2> 12575 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[10052 (1425296528539385856)]} 0 0
[junit4:junit4] 2> 12576 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[51 (1425296528539385857)]} 0 1
[junit4:junit4] 2> 12579 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10052 (1425296528542531584)]} 0 1
[junit4:junit4] 2> 12579 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[51 (1425296528542531585)]} 0 1
[junit4:junit4] 2> 12582 T2748 C199 P59488 /update {wt=javabin&version=2} {delete=[10052 (-1425296528546725888)]} 0 0
[junit4:junit4] 2> 12583 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[52 (1425296528547774464)]} 0 0
[junit4:junit4] 2> 12585 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[10052 (-1425296528549871616)]} 0 0
[junit4:junit4] 2> 12586 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[52 (1425296528550920192)]} 0 0
[junit4:junit4] 2> 12594 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[10053 (1425296528558260224)]} 0 1
[junit4:junit4] 2> 12595 T2751 C199 P59488 /update {wt=javabin&version=2} {delete=[52 (-1425296528560357376)]} 0 0
[junit4:junit4] 2> 12596 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10053 (1425296528561405952)]} 0 0
[junit4:junit4] 2> 12598 T2769 C200 P59500 /update {wt=javabin&version=2} {delete=[52 (-1425296528563503104)]} 0 0
[junit4:junit4] 2> 12599 T2750 C199 P59488 /update {wt=javabin&version=2} {delete=[10053 (-1425296528564551680)]} 0 0
[junit4:junit4] 2> 12602 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[53 (1425296528567697408)]} 0 0
[junit4:junit4] 2> 12604 T2768 C200 P59500 /update {wt=javabin&version=2} {delete=[10053 (-1425296528569794560)]} 0 0
[junit4:junit4] 2> 12606 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[53 (1425296528571891712)]} 0 0
[junit4:junit4] 2> 12606 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[10054 (1425296528571891712)]} 0 0
[junit4:junit4] 2> 12609 T2746 C199 P59488 /update {wt=javabin&version=2} {delete=[53 (-1425296528575037440)]} 0 0
[junit4:junit4] 2> 12609 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[10054 (1425296528575037440)]} 0 0
[junit4:junit4] 2> 12612 T2767 C200 P59500 /update {wt=javabin&version=2} {delete=[53 (-1425296528578183168)]} 0 0
[junit4:junit4] 2> 12612 T2751 C199 P59488 /update {wt=javabin&version=2} {delete=[10054 (-1425296528578183168)]} 0 0
[junit4:junit4] 2> 12615 T2769 C200 P59500 /update {wt=javabin&version=2} {delete=[10054 (-1425296528581328896)]} 0 0
[junit4:junit4] 2> 12615 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[54 (1425296528581328896)]} 0 0
[junit4:junit4] 2> 12619 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[10055 (1425296528584474624)]} 0 1
[junit4:junit4] 2> 12621 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[54 (1425296528587620352)]} 0 0
[junit4:junit4] 2> 12622 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[10055 (1425296528588668928)]} 0 0
[junit4:junit4] 2> 12624 T2748 C199 P59488 /update {wt=javabin&version=2} {delete=[54 (-1425296528590766080)]} 0 0
[junit4:junit4] 2> 12625 T2747 C199 P59488 /update {wt=javabin&version=2} {delete=[10055 (-1425296528591814656)]} 0 0
[junit4:junit4] 2> 12627 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[54 (-1425296528593911808)]} 0 0
[junit4:junit4] 2> 12628 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[10055 (-1425296528594960384)]} 0 0
[junit4:junit4] 2> 12631 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[10056 (1425296528598106112)]} 0 0
[junit4:junit4] 2> 12636 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[55 (1425296528597057536)]} 0 6
[junit4:junit4] 2> 12638 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[55 (1425296528605446144)]} 0 0
[junit4:junit4] 2> 12638 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10056 (1425296528604397568)]} 0 1
[junit4:junit4] 2> 12644 T2750 C199 P59488 /update {wt=javabin&version=2} {delete=[55 (-1425296528609640448)]} 0 2
[junit4:junit4] 2> 12645 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[10057 (1425296528609640449)]} 0 3
[junit4:junit4] 2> 12649 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[55 (-1425296528616980480)]} 0 0
[junit4:junit4] 2> 12649 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10057 (1425296528616980481)]} 0 0
[junit4:junit4] 2> 12655 T2748 C199 P59488 /update {wt=javabin&version=2} {delete=[10056 (-1425296528623271936)]} 0 0
[junit4:junit4] 2> 12659 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[56 (1425296528623271937)]} 0 4
[junit4:junit4] 2> 12662 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[10056 (-1425296528630611968)]} 0 0
[junit4:junit4] 2> 12662 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[56 (1425296528630611969)]} 0 0
[junit4:junit4] 2> 12665 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[10058 (1425296528633757696)]} 0 0
[junit4:junit4] 2> 12668 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[57 (1425296528636903424)]} 0 0
[junit4:junit4] 2> 12672 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[57 (1425296528640049152)]} 0 1
[junit4:junit4] 2> 12674 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[10058 (1425296528643194880)]} 0 0
[junit4:junit4] 2> 12677 T2750 C199 P59488 /update {wt=javabin&version=2} {delete=[56 (-1425296528645292032)]} 0 1
[junit4:junit4] 2> 12679 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[10059 (1425296528647389184)]} 0 1
[junit4:junit4] 2> 12681 T2767 C200 P59500 /update {wt=javabin&version=2} {delete=[56 (-1425296528650534912)]} 0 2
[junit4:junit4] 2> 12684 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[58 (1425296528653680640)]} 0 0
[junit4:junit4] 2> 12686 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10059 (1425296528655777792)]} 0 1
[junit4:junit4] 2> 12687 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[58 (1425296528656826368)]} 0 0
[junit4:junit4] 2> 12690 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[59 (1425296528659972096)]} 0 0
[junit4:junit4] 2> 12691 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[10060 (1425296528661020672)]} 0 0
[junit4:junit4] 2> 12694 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[59 (1425296528663117824)]} 0 1
[junit4:junit4] 2> 12695 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[10060 (1425296528665214976)]} 0 0
[junit4:junit4] 2> 12699 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[60 (1425296528667312128)]} 0 3
[junit4:junit4] 2> 12702 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[10061 (1425296528672555008)]} 0 1
[junit4:junit4] 2> 12705 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[60 (1425296528673603584)]} 0 2
[junit4:junit4] 2> 12721 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[61 (1425296528690380800)]} 0 2
[junit4:junit4] 2> 12722 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10061 (1425296528693526528)]} 0 0
[junit4:junit4] 2> 12725 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[61 (1425296528696672256)]} 0 0
[junit4:junit4] 2> 12727 T2748 C199 P59488 /update {wt=javabin&version=2} {delete=[60 (-1425296528698769408)]} 0 0
[junit4:junit4] 2> 12728 T2747 C199 P59488 /update {wt=javabin&version=2} {delete=[10060 (-1425296528699817984)]} 0 0
[junit4:junit4] 2> 12730 T2768 C200 P59500 /update {wt=javabin&version=2} {delete=[60 (-1425296528701915136)]} 0 0
[junit4:junit4] 2> 12731 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[10060 (-1425296528702963712)]} 0 0
[junit4:junit4] 2> 12733 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[62 (1425296528705060864)]} 0 0
[junit4:junit4] 2> 12736 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[62 (1425296528708206592)]} 0 0
[junit4:junit4] 2> 12737 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[10062 (1425296528709255168)]} 0 0
[junit4:junit4] 2> 12739 T2750 C199 P59488 /update {wt=javabin&version=2} {delete=[62 (-1425296528711352320)]} 0 0
[junit4:junit4] 2> 12741 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10062 (1425296528713449472)]} 0 0
[junit4:junit4] 2> 12743 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[62 (-1425296528715546624)]} 0 0
[junit4:junit4] 2> 12744 T2749 C199 P59488 /update {wt=javabin&version=2} {delete=[10062 (-1425296528716595200)]} 0 0
[junit4:junit4] 2> 12746 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[63 (1425296528718692352)]} 0 0
[junit4:junit4] 2> 12748 T2768 C200 P59500 /update {wt=javabin&version=2} {delete=[10062 (-1425296528720789504)]} 0 0
[junit4:junit4] 2> 12750 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[63 (1425296528722886656)]} 0 0
[junit4:junit4] 2> 12752 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[10063 (1425296528724983808)]} 0 1
[junit4:junit4] 2> 12753 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[64 (1425296528726032384)]} 0 0
[junit4:junit4] 2> 12755 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10063 (1425296528727080960)]} 0 1
[junit4:junit4] 2> 12757 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[64 (1425296528730226688)]} 0 0
[junit4:junit4] 2> 12759 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[10064 (1425296528732323840)]} 0 1
[junit4:junit4] 2> 12761 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[65 (1425296528734420992)]} 0 0
[junit4:junit4] 2> 12763 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[10064 (1425296528735469568)]} 0 1
[junit4:junit4] 2> 12764 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[65 (1425296528737566720)]} 0 0
[junit4:junit4] 2> 12776 T2748 C199 P59488 /update {wt=javabin&version=2} {delete=[64 (-1425296528750149632)]} 0 0
[junit4:junit4] 2> 12778 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[10065 (1425296528739663872)]} 0 13
[junit4:junit4] 2> 12785 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[64 (-1425296528759586816)]} 0 0
[junit4:junit4] 2> 12789 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[66 (1425296528762732544)]} 0 1
[junit4:junit4] 2> 12819 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[66 (1425296528793141248)]} 0 2
[junit4:junit4] 2> 12821 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10065 (1425296528764829696)]} 0 31
[junit4:junit4] 2> 12824 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[67 (1425296528800481280)]} 0 0
[junit4:junit4] 2> 12826 T2746 C199 P59488 /update {wt=javabin&version=2} {delete=[10064 (-1425296528801529856)]} 0 0
[junit4:junit4] 2> 12827 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[67 (1425296528803627008)]} 0 0
[junit4:junit4] 2> 12829 T2768 C200 P59500 /update {wt=javabin&version=2} {delete=[10064 (-1425296528805724160)]} 0 1
[junit4:junit4] 2> 12830 T2750 C199 P59488 /update {wt=javabin&version=2} {delete=[66 (-1425296528806772736)]} 0 0
[junit4:junit4] 2> 12832 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[10066 (1425296528807821312)]} 0 1
[junit4:junit4] 2> 12833 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[66 (-1425296528809918464)]} 0 0
[junit4:junit4] 2> 12835 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10066 (1425296528810967040)]} 0 1
[junit4:junit4] 2> 12836 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[68 (1425296528813064192)]} 0 0
[junit4:junit4] 2> 12838 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[10067 (1425296528815161344)]} 0 0
[junit4:junit4] 2> 12841 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[68 (1425296528818307072)]} 0 0
[junit4:junit4] 2> 12843 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[10067 (1425296528819355648)]} 0 1
[junit4:junit4] 2> 12844 T2751 C199 P59488 /update {wt=javabin&version=2} {delete=[67 (-1425296528821452800)]} 0 0
[junit4:junit4] 2> 12845 T2746 C199 P59488 /update {wt=javabin&version=2} {delete=[10066 (-1425296528822501376)]} 0 0
[junit4:junit4] 2> 12847 T2768 C200 P59500 /update {wt=javabin&version=2} {delete=[67 (-1425296528824598528)]} 0 0
[junit4:junit4] 2> 12848 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[10066 (-1425296528825647104)]} 0 0
[junit4:junit4] 2> 12850 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[69 (1425296528826695680)]} 0 1
[junit4:junit4] 2> 12851 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[10068 (1425296528828792832)]} 0 0
[junit4:junit4] 2> 12853 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[69 (1425296528830889984)]} 0 0
[junit4:junit4] 2> 12856 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10068 (1425296528834035712)]} 0 0
[junit4:junit4] 2> 12858 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[70 (1425296528835084288)]} 0 1
[junit4:junit4] 2> 12861 T2747 C199 P59488 /update {wt=javabin&version=2} {delete=[10067 (-1425296528839278592)]} 0 0
[junit4:junit4] 2> 12862 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[70 (1425296528840327168)]} 0 0
[junit4:junit4] 2> 12864 T2768 C200 P59500 /update {wt=javabin&version=2} {delete=[10067 (-1425296528842424320)]} 0 0
[junit4:junit4] 2> 12865 T2751 C199 P59488 /update {wt=javabin&version=2} {delete=[70 (-1425296528843472896)]} 0 0
[junit4:junit4] 2> 12867 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[10069 (1425296528845570048)]} 0 0
[junit4:junit4] 2> 12869 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[70 (-1425296528847667200)]} 0 0
[junit4:junit4] 2> 12870 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10069 (1425296528848715776)]} 0 0
[junit4:junit4] 2> 12874 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[71 (1425296528850812928)]} 0 2
[junit4:junit4] 2> 12884 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[10070 (1425296528853958656)]} 0 9
[junit4:junit4] 2> 12887 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[71 (1425296528864444416)]} 0 2
[junit4:junit4] 2> 12890 T2749 C199 P59488 /update {wt=javabin&version=2} {delete=[71 (-1425296528869687296)]} 0 0
[junit4:junit4] 2> 12892 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[10070 (1425296528870735872)]} 0 1
[junit4:junit4] 2> 12894 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[71 (-1425296528873881600)]} 0 0
[junit4:junit4] 2> 12897 T2747 C199 P59488 /update {wt=javabin&version=2} {delete=[10070 (-1425296528877027328)]} 0 0
[junit4:junit4] 2> 12898 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[72 (1425296528878075904)]} 0 0
[junit4:junit4] 2> 12902 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[10070 (-1425296528882270208)]} 0 0
[junit4:junit4] 2> 12904 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[72 (1425296528883318784)]} 0 1
[junit4:junit4] 2> 12906 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[73 (1425296528886464512)]} 0 0
[junit4:junit4] 2> 12908 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[10071 (1425296528888561664)]} 0 1
[junit4:junit4] 2> 12909 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[73 (1425296528889610240)]} 0 0
[junit4:junit4] 2> 12911 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[10071 (1425296528891707392)]} 0 0
[junit4:junit4] 2> 12913 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[74 (1425296528893804544)]} 0 0
[junit4:junit4] 2> 12915 T2749 C199 P59488 /update {wt=javabin&version=2} {delete=[10071 (-1425296528895901696)]} 0 0
[junit4:junit4] 2> 12917 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[74 (1425296528897998848)]} 0 0
[junit4:junit4] 2> 12918 T2768 C200 P59500 /update {wt=javabin&version=2} {delete=[10071 (-1425296528899047424)]} 0 0
[junit4:junit4] 2> 12921 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[75 (1425296528902193152)]} 0 0
[junit4:junit4] 2> 12922 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[10072 (1425296528903241728)]} 0 0
[junit4:junit4] 2> 12924 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[75 (1425296528905338880)]} 0 0
[junit4:junit4] 2> 12926 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10072 (1425296528907436032)]} 0 0
[junit4:junit4] 2> 12928 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[76 (1425296528908484608)]} 0 1
[junit4:junit4] 2> 12929 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[10073 (1425296528910581760)]} 0 0
[junit4:junit4] 2> 12930 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[76 (1425296528911630336)]} 0 0
[junit4:junit4] 2> 12932 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[10073 (1425296528913727488)]} 0 0
[junit4:junit4] 2> 12935 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[10074 (1425296528916873216)]} 0 0
[junit4:junit4] 2> 12935 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[77 (1425296528914776064)]} 0 2
[junit4:junit4] 2> 12942 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10074 (1425296528923164672)]} 0 1
[junit4:junit4] 2> 12943 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[77 (1425296528920018944)]} 0 5
[junit4:junit4] 2> 12945 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[10075 (1425296528927358976)]} 0 0
[junit4:junit4] 2> 12947 T2751 C199 P59488 /update {wt=javabin&version=2} {delete=[76 (-1425296528929456128)]} 0 0
[junit4:junit4] 2> 12949 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10075 (1425296528931553280)]} 0 0
[junit4:junit4] 2> 12956 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[76 (-1425296528938893312)]} 0 0
[junit4:junit4] 2> 12958 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[10076 (1425296528939941888)]} 0 1
[junit4:junit4] 2> 12962 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[10076 (1425296528945184768)]} 0 0
[junit4:junit4] 2> 12964 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[78 (1425296528947281920)]} 0 0
[junit4:junit4] 2> 12966 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[10077 (1425296528949379072)]} 0 0
[junit4:junit4] 2> 12967 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[78 (1425296528950427648)]} 0 0
[junit4:junit4] 2> 12969 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10077 (1425296528952524800)]} 0 0
[junit4:junit4] 2> 12971 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[79 (1425296528953573376)]} 0 1
[junit4:junit4] 2> 12972 T2747 C199 P59488 /update {wt=javabin&version=2} {delete=[10076 (-1425296528955670528)]} 0 0
[junit4:junit4] 2> 12974 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[79 (1425296528956719104)]} 0 1
[junit4:junit4] 2> 12975 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[10076 (-1425296528958816256)]} 0 0
[junit4:junit4] 2> 12976 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[80 (1425296528959864832)]} 0 0
[junit4:junit4] 2> 12978 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[10078 (1425296528961961984)]} 0 0
[junit4:junit4] 2> 12980 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[80 (1425296528964059136)]} 0 0
[junit4:junit4] 2> 12983 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10078 (1425296528966156288)]} 0 1
[junit4:junit4] 2> 12983 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[81 (1425296528967204864)]} 0 0
[junit4:junit4] 2> 12986 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[10079 (1425296528969302016)]} 0 1
[junit4:junit4] 2> 12987 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[81 (1425296528971399168)]} 0 0
[junit4:junit4] 2> 12991 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[82 (1425296528975593472)]} 0 0
[junit4:junit4] 2> 12994 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[82 (1425296528978739200)]} 0 0
[junit4:junit4] 2> 12997 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[83 (1425296528981884928)]} 0 0
[junit4:junit4] 2> 13009 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[83 (1425296528993419264)]} 0 8
[junit4:junit4] 2> 13012 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[84 (1425296528996564992)]} 0 1
[junit4:junit4] 2> 13012 T2756 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 13014 T2756 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:59509_y_%2Fn",
[junit4:junit4] 2> "base_url":"http://127.0.0.1:59509/y_/n"}
[junit4:junit4] 2> 13016 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[84 (1425296529000759296)]} 0 1
[junit4:junit4] 2> 13020 T2750 C199 P59488 /update {wt=javabin&version=2} {delete=[77 (-1425296529006002176)]} 0 2
[junit4:junit4] 2> 13023 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[77 (-1425296529009147904)]} 0 0
[junit4:junit4] 2> 13024 T2774 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> 13025 T2789 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> 13025 T2761 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> 13025 T2755 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> 13027 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[85 (1425296529013342208)]} 0 1
[junit4:junit4] 2> C198_STATE=coll:collection1 core:collection1 props:{shard=shard1, roles=null, state=recovering, core=collection1, collection=collection1, node_name=127.0.0.1:59509_y_%2Fn, base_url=http://127.0.0.1:59509/y_/n}
[junit4:junit4] 2> 13042 T2784 C198 P59509 oasc.CachingDirectoryFactory.close Releasing directory:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.RecoveryZkTest-1359268679961\jetty2
[junit4:junit4] 2> 13045 T2784 C198 P59509 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@536da9 lockFactory=org.apache.lucene.store.NativeFSLockFactory@16fc003)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> 13046 T2784 C198 P59509 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4] 2> 13048 T2784 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[85 (1425296529016487936)]} 0 8
[junit4:junit4] 2> 13050 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[85 (1425296529016487936)]} 0 20
[junit4:junit4] 2> 13052 T2749 C199 P59488 /update {wt=javabin&version=2} {delete=[80 (-1425296529039556608)]} 0 0
[junit4:junit4] 2> 13060 T2785 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[80 (-1425296529043750912)]} 0 2
[junit4:junit4] 2> 13061 T2768 C200 P59500 /update {wt=javabin&version=2} {delete=[80 (-1425296529043750912)]} 0 6
[junit4:junit4] 2> 13063 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[86 (1425296529051090944)]} 0 0
[junit4:junit4] 2> 13070 T2780 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[86 (1425296529054236672)]} 0 1
[junit4:junit4] 2> 13071 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[86 (1425296529054236672)]} 0 5
[junit4:junit4] 2> 13072 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10079 (1425296528973496320)]} 0 83
[junit4:junit4] 2> 13073 T2746 C199 P59488 /update {wt=javabin&version=2} {delete=[82 (-1425296529061576704)]} 0 0
[junit4:junit4] 2> 13081 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[10080 (1425296529068916736)]} 0 1
[junit4:junit4] 2> 13086 T2781 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[82 (-1425296529071013888)]} 0 2
[junit4:junit4] 2> 13087 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[82 (-1425296529071013888)]} 0 5
[junit4:junit4] 2> 13091 T2782 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10080 (1425296529073111040)]} 0 2
[junit4:junit4] 2> 13091 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[10080 (1425296529073111040)]} 0 7
[junit4:junit4] 2> 13091 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[87 (1425296529080451072)]} 0 0
[junit4:junit4] 2> 13094 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[10081 (1425296529083596800)]} 0 0
[junit4:junit4] 2> 13097 T2783 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[87 (1425296529083596800)]} 0 0
[junit4:junit4] 2> 13100 T2766 C200 P59500 /update {wt=javabin&version=2} {add=[87 (1425296529083596800)]} 0 6
[junit4:junit4] 2> 13101 T2784 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10081 (1425296529086742528)]} 0 1
[junit4:junit4] 2> 13101 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[10081 (1425296529086742528)]} 0 4
[junit4:junit4] 2> 13102 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[88 (1425296529091985408)]} 0 0
[junit4:junit4] 2> 13107 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[10082 (1425296529094082560)]} 0 3
[junit4:junit4] 2> 13109 T2785 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[88 (1425296529095131136)]} 0 1
[junit4:junit4] 2> 13109 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[88 (1425296529095131136)]} 0 4
[junit4:junit4] 2> 13112 T2746 C199 P59488 /update {wt=javabin&version=2} {delete=[84 (-1425296529102471168)]} 0 0
[junit4:junit4] 2> 13115 T2780 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10082 (1425296529100374016)]} 0 0
[junit4:junit4] 2> 13116 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10082 (1425296529100374016)]} 0 6
[junit4:junit4] 2> 13117 T2781 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[84 (-1425296529105616896)]} 0 0
[junit4:junit4] 2> 13118 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[84 (-1425296529105616896)]} 0 3
[junit4:junit4] 2> 13122 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[10083 (1425296529111908352)]} 0 1
[junit4:junit4] 2> 13122 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[89 (1425296529111908353)]} 0 1
[junit4:junit4] 2> 13128 T2782 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10083 (1425296529115054080)]} 0 1
[junit4:junit4] 2> 13128 T2783 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[89 (1425296529115054081)]} 0 1
[junit4:junit4] 2> 13129 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[10083 (1425296529115054080)]} 0 5
[junit4:junit4] 2> 13129 T2766 C200 P59500 /update {wt=javabin&version=2} {add=[89 (1425296529115054081)]} 0 5
[junit4:junit4] 2> 13132 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[10084 (1425296529122394112)]} 0 1
[junit4:junit4] 2> 13133 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[90 (1425296529123442688)]} 0 1
[junit4:junit4] 2> 13141 T2784 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10084 (1425296529127636992)]} 0 3
[junit4:junit4] 2> 13143 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[10084 (1425296529127636992)]} 0 7
[junit4:junit4] 2> 13145 T2785 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[90 (1425296529128685568)]} 0 2
[junit4:junit4] 2> 13145 T2747 C199 P59488 /update {wt=javabin&version=2} {delete=[10077 (-1425296529137074176)]} 0 0
[junit4:junit4] 2> 13146 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[90 (1425296529128685568)]} 0 9
[junit4:junit4] 2> 13148 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[91 (1425296529140219904)]} 0 0
[junit4:junit4] 2> 13150 T2780 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[10077 (-1425296529140219904)]} 0 0
[junit4:junit4] 2> 13151 T2767 C200 P59500 /update {wt=javabin&version=2} {delete=[10077 (-1425296529140219904)]} 0 3
[junit4:junit4] 2> 13153 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[10085 (1425296529145462784)]} 0 0
[junit4:junit4] 2> 13156 T2781 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[91 (1425296529144414208)]} 0 1
[junit4:junit4] 2> 13157 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[91 (1425296529144414208)]} 0 5
[junit4:junit4] 2> 13164 T2751 C199 P59488 /update {wt=javabin&version=2} {delete=[87 (-1425296529156997120)]} 0 0
[junit4:junit4] 2> 13164 T2783 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10085 (1425296529149657088)]} 0 0
[junit4:junit4] 2> 13165 T2766 C200 P59500 /update {wt=javabin&version=2} {add=[10085 (1425296529149657088)]} 0 8
[junit4:junit4] 2> 13167 T2748 C199 P59488 /update {wt=javabin&version=2} {delete=[10080 (-1425296529160142848)]} 0 0
[junit4:junit4] 2> 13171 T2782 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[87 (-1425296529160142848)]} 0 0
[junit4:junit4] 2> 13172 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[87 (-1425296529160142848)]} 0 5
[junit4:junit4] 2> 13173 T2784 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[10080 (-1425296529164337152)]} 0 0
[junit4:junit4] 2> 13175 T2768 C200 P59500 /update {wt=javabin&version=2} {delete=[10080 (-1425296529164337152)]} 0 4
[junit4:junit4] 2> 13176 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[92 (1425296529169580032)]} 0 1
[junit4:junit4] 2> 13182 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[10086 (1425296529175871488)]} 0 0
[junit4:junit4] 2> 13184 T2785 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[92 (1425296529175871488)]} 0 0
[junit4:junit4] 2> 13192 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[92 (1425296529175871488)]} 0 10
[junit4:junit4] 2> 13195 T2780 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10086 (1425296529186357248)]} 0 0
[junit4:junit4] 2> 13195 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[93 (1425296529189502976)]} 0 0
[junit4:junit4] 2> 13197 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10086 (1425296529186357248)]} 0 12
[junit4:junit4] 2> 13201 T2750 C199 P59488 /update {wt=javabin&version=2} {delete=[10082 (-1425296529195794432)]} 0 0
[junit4:junit4] 2> 13203 T2781 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[93 (1425296529195794432)]} 0 0
[junit4:junit4] 2> 13204 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[93 (1425296529195794432)]} 0 4
[junit4:junit4] 2> 13206 T2783 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[10082 (-1425296529198940160)]} 0 0
[junit4:junit4] 2> 13208 T2766 C200 P59500 /update {wt=javabin&version=2} {delete=[10082 (-1425296529198940160)]} 0 4
[junit4:junit4] 2> 13210 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[94 (1425296529203134464)]} 0 2
[junit4:junit4] 2> 13211 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[10087 (1425296529205231616)]} 0 1
[junit4:junit4] 2> 13217 T2782 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[94 (1425296529208377344)]} 0 0
[junit4:junit4] 2> 13219 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[94 (1425296529208377344)]} 0 6
[junit4:junit4] 2> 13219 T2784 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10087 (1425296529210474496)]} 0 0
[junit4:junit4] 2> 13220 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[10087 (1425296529210474496)]} 0 6
[junit4:junit4] 2> 13222 T2749 C199 P59488 /update {wt=javabin&version=2} {delete=[89 (-1425296529217814528)]} 0 0
[junit4:junit4] 2> 13223 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[10088 (1425296529218863104)]} 0 0
[junit4:junit4] 2> 13227 T2785 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[89 (-1425296529220960256)]} 0 0
[junit4:junit4] 2> 13228 T2769 C200 P59500 /update {wt=javabin&version=2} {delete=[89 (-1425296529220960256)]} 0 3
[junit4:junit4] 2> 13229 T2781 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10088 (1425296529223057408)]} 0 0
[junit4:junit4] 2> 13230 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10088 (1425296529223057408)]} 0 3
[junit4:junit4] 2> 13231 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[95 (1425296529226203136)]} 0 1
[junit4:junit4] 2> 13232 T2750 C199 P59488 /update {wt=javabin&version=2} {delete=[10084 (-1425296529228300288)]} 0 0
[junit4:junit4] 2> 13240 T2782 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[10084 (-1425296529231446016)]} 0 0
[junit4:junit4] 2> 13241 T2766 C200 P59500 /update {wt=javabin&version=2} {delete=[10084 (-1425296529231446016)]} 0 6
[junit4:junit4] 2> 13243 T2783 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[95 (1425296529229348864)]} 0 7
[junit4:junit4] 2> 13244 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[95 (1425296529229348864)]} 0 11
[junit4:junit4] 2> 13245 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[10089 (1425296529241931776)]} 0 0
[junit4:junit4] 2> 13247 T2748 C199 P59488 /update {wt=javabin&version=2} {delete=[90 (-1425296529244028928)]} 0 0
[junit4:junit4] 2> 13251 T2784 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10089 (1425296529245077504)]} 0 0
[junit4:junit4] 2> 13253 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[10089 (1425296529245077504)]} 0 5
[junit4:junit4] 2> 13253 T2785 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[90 (-1425296529247174656)]} 0 0
[junit4:junit4] 2> 13254 T2768 C200 P59500 /update {wt=javabin&version=2} {delete=[90 (-1425296529247174656)]} 0 4
[junit4:junit4] 2> 13256 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[10090 (1425296529253466112)]} 0 0
[junit4:junit4] 2> 13257 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[96 (1425296529254514688)]} 0 0
[junit4:junit4] 2> 13263 T2780 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10090 (1425296529257660416)]} 0 0
[junit4:junit4] 2> 13264 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10090 (1425296529257660416)]} 0 4
[junit4:junit4] 2> 13264 T2781 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[96 (1425296529258708992)]} 0 0
[junit4:junit4] 2> 13265 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[96 (1425296529258708992)]} 0 4
[junit4:junit4] 2> 13267 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[10091 (1425296529265000448)]} 0 0
[junit4:junit4] 2> 13268 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[97 (1425296529266049024)]} 0 0
[junit4:junit4] 2> 13274 T2782 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10091 (1425296529269194752)]} 0 1
[junit4:junit4] 2> 13275 T2782 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[97 (1425296529269194753)]} 0 0
[junit4:junit4] 2> 13276 T2766 C200 P59500 /update {wt=javabin&version=2} {add=[10091 (1425296529269194752)]} 0 6
[junit4:junit4] 2> 13277 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[97 (1425296529269194753)]} 0 6
[junit4:junit4] 2> 13281 T2748 C199 P59488 /update {wt=javabin&version=2} {delete=[10087 (-1425296529279680513)]} 0 0
[junit4:junit4] 2> 13281 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[98 (1425296529279680512)]} 0 0
[junit4:junit4] 2> 13287 T2784 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[10087 (-1425296529283874817)]} 0 0
[junit4:junit4] 2> 13288 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[10087 (-1425296529283874817)]} 0 3
[junit4:junit4] 2> 13288 T2785 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[98 (1425296529283874816)]} 0 0
[junit4:junit4] 2> 13289 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[98 (1425296529283874816)]} 0 4
[junit4:junit4] 2> 13293 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[10092 (1425296529290166272)]} 0 2
[junit4:junit4] 2> 13294 T2747 C199 P59488 /update {wt=javabin&version=2} {delete=[92 (-1425296529293312000)]} 0 2
[junit4:junit4] 2> 13301 T2780 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[92 (-1425296529296457728)]} 0 0
[junit4:junit4] 2> 13302 T2767 C200 P59500 /update {wt=javabin&version=2} {delete=[92 (-1425296529296457728)]} 0 5
[junit4:junit4] 2> 13303 T2781 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10092 (1425296529295409152)]} 0 0
[junit4:junit4] 2> 13304 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[10092 (1425296529295409152)]} 0 8
[junit4:junit4] 2> 13305 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[99 (1425296529304846336)]} 0 0
[junit4:junit4] 2> 13307 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[10093 (1425296529305894912)]} 0 1
[junit4:junit4] 2> 13312 T2783 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[99 (1425296529307992064)]} 0 1
[junit4:junit4] 2> 13312 T2766 C200 P59500 /update {wt=javabin&version=2} {add=[99 (1425296529307992064)]} 0 4
[junit4:junit4] 2> 13312 T2782 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10093 (1425296529310089216)]} 0 0
[junit4:junit4] 2> 13313 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[10093 (1425296529310089216)]} 0 3
[junit4:junit4] 2> 13315 T2751 C199 P59488 /update {wt=javabin&version=2} {delete=[96 (-1425296529315332096)]} 0 0
[junit4:junit4] 2> 13316 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[10094 (1425296529316380672)]} 0 0
[junit4:junit4] 2> 13321 T2784 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[96 (-1425296529319526400)]} 0 0
[junit4:junit4] 2> 13322 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[96 (-1425296529319526400)]} 0 3
[junit4:junit4] 2> 13325 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[100 (1425296529325817856)]} 0 0
[junit4:junit4] 2> 13326 T2785 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10094 (1425296529320574976)]} 0 3
[junit4:junit4] 2> 13327 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[10094 (1425296529320574976)]} 0 7
[junit4:junit4] 2> 13331 T2747 C199 P59488 /update {wt=javabin&version=2} {delete=[10089 (-1425296529332109312)]} 0 0
[junit4:junit4] 2> 13333 T2780 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[100 (1425296529330012160)]} 0 1
[junit4:junit4] 2> 13334 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[100 (1425296529330012160)]} 0 5
[junit4:junit4] 2> 13336 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[101 (1425296529337352192)]} 0 0
[junit4:junit4] 2> 13337 T2781 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[10089 (-1425296529335255040)]} 0 0
[junit4:junit4] 2> 13339 T2768 C200 P59500 /update {wt=javabin&version=2} {delete=[10089 (-1425296529335255040)]} 0 5
[junit4:junit4] 2> 13342 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[10095 (1425296529342595072)]} 0 1
[junit4:junit4] 2> 13344 T2783 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[101 (1425296529342595072)]} 0 0
[junit4:junit4] 2> 13345 T2766 C200 P59500 /update {wt=javabin&version=2} {add=[101 (1425296529342595072)]} 0 4
[junit4:junit4] 2> 13347 T2782 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10095 (1425296529345740800)]} 0 0
[junit4:junit4] 2> 13348 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[10095 (1425296529345740800)]} 0 4
[junit4:junit4] 2> 13348 T2751 C199 P59488 /update {wt=javabin&version=2} {delete=[97 (-1425296529349935104)]} 0 0
[junit4:junit4] 2> 13350 T2748 C199 P59488 /update {wt=javabin&version=2} {delete=[10090 (-1425296529352032256)]} 0 0
[junit4:junit4] 2> 13354 T2784 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[97 (-1425296529353080832)]} 0 1
[junit4:junit4] 2> 13354 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[97 (-1425296529353080832)]} 0 3
[junit4:junit4] 2> 13356 T2785 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[10090 (-1425296529355177984)]} 0 0
[junit4:junit4] 2> 13357 T2767 C200 P59500 /update {wt=javabin&version=2} {delete=[10090 (-1425296529355177984)]} 0 4
[junit4:junit4] 2> 13360 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[102 (1425296529361469440)]} 0 0
[junit4:junit4] 2> 13360 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[10096 (1425296529362518016)]} 0 0
[junit4:junit4] 2> 13366 T2780 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[102 (1425296529364615168)]} 0 1
[junit4:junit4] 2> 13366 T2781 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10096 (1425296529365663744)]} 0 0
[junit4:junit4] 2> 13367 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[102 (1425296529364615168)]} 0 5
[junit4:junit4] 2> 13367 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[10096 (1425296529365663744)]} 0 4
[junit4:junit4] 2> 13370 T2746 C199 P59488 /update {wt=javabin&version=2} {delete=[98 (-1425296529373003776)]} 0 0
[junit4:junit4] 2> 13371 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[10097 (1425296529373003777)]} 0 0
[junit4:junit4] 2> 13375 T2783 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[98 (-1425296529376149505)]} 0 0
[junit4:junit4] 2> 13377 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[98 (-1425296529376149505)]} 0 4
[junit4:junit4] 2> 13377 T2782 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10097 (1425296529376149504)]} 0 0
[junit4:junit4] 2> 13379 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[10097 (1425296529376149504)]} 0 6
[junit4:junit4] 2> 13381 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[10098 (1425296529384538112)]} 0 0
[junit4:junit4] 2> 13382 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[103 (1425296529383489536)]} 0 2
[junit4:junit4] 2> 13402 T2784 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10098 (1425296529387683840)]} 0 0
[junit4:junit4] 2> 13403 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10098 (1425296529387683840)]} 0 19
[junit4:junit4] 2> 13404 T2785 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[103 (1425296529397121024)]} 0 1
[junit4:junit4] 2> 13406 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[103 (1425296529397121024)]} 0 21
[junit4:junit4] 2> 13406 T2749 C199 P59488 /update {wt=javabin&version=2} {delete=[10092 (-1425296529410752512)]} 0 0
[junit4:junit4] 2> 13408 T2747 C199 P59488 /update {wt=javabin&version=2} {delete=[99 (-1425296529412849664)]} 0 0
[junit4:junit4] 2> 13411 T2780 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[10092 (-1425296529413898240)]} 0 0
[junit4:junit4] 2> 13412 T2766 C200 P59500 /update {wt=javabin&version=2} {delete=[10092 (-1425296529413898240)]} 0 3
[junit4:junit4] 2> 13413 T2781 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[99 (-1425296529415995392)]} 0 0
[junit4:junit4] 2> 13414 T2768 C200 P59500 /update {wt=javabin&version=2} {delete=[99 (-1425296529415995392)]} 0 3
[junit4:junit4] 2> 13415 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[10099 (1425296529420189696)]} 0 0
[junit4:junit4] 2> 13417 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[104 (1425296529422286848)]} 0 0
[junit4:junit4] 2> 13423 T2783 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10099 (1425296529425432576)]} 0 0
[junit4:junit4] 2> 13424 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[10099 (1425296529425432576)]} 0 4
[junit4:junit4] 2> 13427 T2782 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[104 (1425296529427529728)]} 0 2
[junit4:junit4] 2> 13427 T2751 C199 P59488 /update {wt=javabin&version=2} {delete=[10096 (-1425296529432772608)]} 0 0
[junit4:junit4] 2> 13428 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[104 (1425296529427529728)]} 0 6
[junit4:junit4] 2> 13431 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[105 (1425296529435918336)]} 0 1
[junit4:junit4] 2> 13432 T2784 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[10096 (-1425296529435918336)]} 0 0
[junit4:junit4] 2> 13433 T2767 C200 P59500 /update {wt=javabin&version=2} {delete=[10096 (-1425296529435918336)]} 0 3
[junit4:junit4] 2> 13436 T2785 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[105 (1425296529439064064)]} 0 1
[junit4:junit4] 2> 13436 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[105 (1425296529439064064)]} 0 3
[junit4:junit4] 2> 13439 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[10100 (1425296529443258368)]} 0 2
[junit4:junit4] 2> 13440 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[106 (1425296529446404096)]} 0 0
[junit4:junit4] 2> 13444 T2780 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10100 (1425296529447452672)]} 0 0
[junit4:junit4] 2> 13445 T2766 C200 P59500 /update {wt=javabin&version=2} {add=[10100 (1425296529447452672)]} 0 4
[junit4:junit4] 2> 13446 T2781 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[106 (1425296529449549824)]} 0 0
[junit4:junit4] 2> 13447 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[106 (1425296529449549824)]} 0 4
[junit4:junit4] 2> 13448 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[10101 (1425296529453744128)]} 0 1
[junit4:junit4] 2> 13449 T2748 C199 P59488 /update {wt=javabin&version=2} {delete=[101 (-1425296529455841280)]} 0 0
[junit4:junit4] 2> 13453 T2783 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10101 (1425296529456889856)]} 0 0
[junit4:junit4] 2> 13455 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[10101 (1425296529456889856)]} 0 5
[junit4:junit4] 2> 13455 T2782 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[101 (-1425296529458987008)]} 0 0
[junit4:junit4] 2> 13456 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[101 (-1425296529458987008)]} 0 4
[junit4:junit4] 2> 13457 T2751 C199 P59488 /update {wt=javabin&version=2} {delete=[10097 (-1425296529464229888)]} 0 0
[junit4:junit4] 2> 13460 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[107 (1425296529467375616)]} 0 0
[junit4:junit4] 2> 13464 T2784 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[10097 (-1425296529468424192)]} 0 0
[junit4:junit4] 2> 13465 T2767 C200 P59500 /update {wt=javabin&version=2} {delete=[10097 (-1425296529468424192)]} 0 4
[junit4:junit4] 2> 13466 T2785 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[107 (1425296529470521344)]} 0 0
[junit4:junit4] 2> 13467 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[107 (1425296529470521344)]} 0 4
[junit4:junit4] 2> 13468 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[10102 (1425296529474715648)]} 0 1
[junit4:junit4] 2> 13469 T2750 C199 P59488 /update {wt=javabin&version=2} {delete=[103 (-1425296529476812800)]} 0 0
[junit4:junit4] 2> 13473 T2780 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10102 (1425296529477861376)]} 0 0
[junit4:junit4] 2> 13475 T2766 C200 P59500 /update {wt=javabin&version=2} {add=[10102 (1425296529477861376)]} 0 5
[junit4:junit4] 2> 13475 T2781 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[103 (-1425296529479958528)]} 0 0
[junit4:junit4] 2> 13476 T2768 C200 P59500 /update {wt=javabin&version=2} {delete=[103 (-1425296529479958528)]} 0 4
[junit4:junit4] 2> 13477 T2746 C199 P59488 /update {wt=javabin&version=2} {delete=[10098 (-1425296529485201408)]} 0 0
[junit4:junit4] 2> 13481 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[108 (1425296529487298560)]} 0 2
[junit4:junit4] 2> 13483 T2783 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[10098 (-1425296529489395712)]} 0 0
[junit4:junit4] 2> 13484 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[10098 (-1425296529489395712)]} 0 3
[junit4:junit4] 2> 13487 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[10103 (1425296529494638592)]} 0 1
[junit4:junit4] 2> 13489 T2782 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[108 (1425296529492541440)]} 0 0
[junit4:junit4] 2> 13490 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[108 (1425296529492541440)]} 0 6
[junit4:junit4] 2> 13493 T2784 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10103 (1425296529498832896)]} 0 0
[junit4:junit4] 2> 13493 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[109 (1425296529501978624)]} 0 0
[junit4:junit4] 2> 13495 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10103 (1425296529498832896)]} 0 5
[junit4:junit4] 2> 13499 T2747 C199 P59488 /update {wt=javabin&version=2} {delete=[10099 (-1425296529508270080)]} 0 0
[junit4:junit4] 2> 13501 T2785 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[109 (1425296529506172928)]} 0 0
[junit4:junit4] 2> 13502 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[109 (1425296529506172928)]} 0 5
[junit4:junit4] 2> 13504 T2780 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[10099 (-1425296529511415808)]} 0 0
[junit4:junit4] 2> 13505 T2766 C200 P59500 /update {wt=javabin&version=2} {delete=[10099 (-1425296529511415808)]} 0 3
[junit4:junit4] 2> 13506 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[110 (1425296529514561536)]} 0 1
[junit4:junit4] 2> 13507 T2746 C199 P59488 /update {wt=javabin&version=2} {add=[10104 (1425296529516658688)]} 0 0
[junit4:junit4] 2> 13513 T2781 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[110 (1425296529517707264)]} 0 2
[junit4:junit4] 2> 13514 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[110 (1425296529517707264)]} 0 6
[junit4:junit4] 2> 13514 T2783 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10104 (1425296529519804416)]} 0 1
[junit4:junit4] 2> 13515 T2765 C200 P59500 /update {wt=javabin&version=2} {add=[10104 (1425296529519804416)]} 0 5
[junit4:junit4] 2> 13516 T2748 C199 P59488 /update {wt=javabin&version=2} {delete=[107 (-1425296529526095872)]} 0 0
[junit4:junit4] 2> 13517 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[10105 (1425296529527144448)]} 0 0
[junit4:junit4] 2> 13522 T2782 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[107 (-1425296529530290176)]} 0 0
[junit4:junit4] 2> 13523 T2770 C200 P59500 /update {wt=javabin&version=2} {delete=[107 (-1425296529530290176)]} 0 3
[junit4:junit4] 2> 13525 T2784 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10105 (1425296529532387328)]} 0 0
[junit4:junit4] 2> 13525 T2749 C199 P59488 /update {wt=javabin&version=2} {add=[111 (1425296529535533056)]} 0 0
[junit4:junit4] 2> 13526 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[10105 (1425296529532387328)]} 0 4
[junit4:junit4] 2> 13529 T2747 C199 P59488 /update {wt=javabin&version=2} {add=[10106 (1425296529539727360)]} 0 0
[junit4:junit4] 2> 13532 T2785 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[111 (1425296529538678784)]} 0 1
[junit4:junit4] 2> 13532 T2769 C200 P59500 /update {wt=javabin&version=2} {add=[111 (1425296529538678784)]} 0 4
[junit4:junit4] 2> 13534 T2780 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10106 (1425296529542873088)]} 0 0
[junit4:junit4] 2> 13535 T2766 C200 P59500 /update {wt=javabin&version=2} {add=[10106 (1425296529542873088)]} 0 3
[junit4:junit4] 2> 13535 T2750 C199 P59488 /update {wt=javabin&version=2} {add=[112 (1425296529546018816)]} 0 0
[junit4:junit4] 2> 13538 T2746 C199 P59488 /update {wt=javabin&version=2} {delete=[10101 (-1425296529549164544)]} 0 0
[junit4:junit4] 2> 13543 T2781 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[10101 (-1425296529552310272)]} 0 0
[junit4:junit4] 2> 13543 T2783 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[112 (1425296529550213120)]} 0 0
[junit4:junit4] 2> 13544 T2765 C200 P59500 /update {wt=javabin&version=2} {delete=[10101 (-1425296529552310272)]} 0 3
[junit4:junit4] 2> 13545 T2768 C200 P59500 /update {wt=javabin&version=2} {add=[112 (1425296529550213120)]} 0 6
[junit4:junit4] 2> 13547 T2748 C199 P59488 /update {wt=javabin&version=2} {add=[10107 (1425296529558601728)]} 0 0
[junit4:junit4] 2> 13549 T2751 C199 P59488 /update {wt=javabin&version=2} {add=[113 (1425296529558601729)]} 0 2
[junit4:junit4] 2> 13553 T2782 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[10107 (1425296529561747456)]} 0 0
[junit4:junit4] 2> 13555 T2782 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {add=[113 (1425296529563844608)]} 0 0
[junit4:junit4] 2> 13556 T2770 C200 P59500 /update {wt=javabin&version=2} {add=[10107 (1425296529561747456)]} 0 6
[junit4:junit4] 2> 13556 T2767 C200 P59500 /update {wt=javabin&version=2} {add=[113 (1425296529563844608)]} 0 4
[junit4:junit4] 2> 13567 T2749 C199 P59488 /update {wt=javabin&version=2} {delete=[108 (-1425296529579573248)]} 0 0
[junit4:junit4] 2> 13570 T2747 C199 P59488 /update {wt=javabin&version=2} {delete=[10103 (-1425296529582718976)]} 0 1
[junit4:junit4] 2> 13583 T2785 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&update.distrib=FROMLEADER&wt=javabin&version=2} {delete=[108 (-1425296529583767552)]} 0 1
[junit4:junit4] 2> 13584 T2769 C200 P59500 /update {wt=javabin&version=2} {delete=[108 (-1425296529583767552)]} 0 14
[junit4:junit4] 2> 13585 T2780 C198 P59509 /update {distrib.from=http://127.0.0.1:59500/y_/n/collection1/&
[...truncated too long message...]
r.doStop stopped o.e.j.s.ServletContextHandler{/y_/n,null}
[junit4:junit4] 2> 81452 T2733 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=13BD914BC7EE6157 -Dtests.slow=true -Dtests.locale=zh_SG -Dtests.timezone=Asia/Amman -Dtests.file.encoding=ISO-8859-1
[junit4:junit4] FAILURE 81.5s | RecoveryZkTest.testDistribSearch <<<
[junit4:junit4] > Throwable #1: java.lang.AssertionError: expected:<244> but was:<2>
[junit4:junit4] > at __randomizedtesting.SeedInfo.seed([13BD914BC7EE6157:925B1F53B0B1016B]: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> 81481 T2733 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4] 2> NOTE: test params are: codec=Lucene40, sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=zh_SG, timezone=Asia/Amman
[junit4:junit4] 2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.7.0_10 (32-bit)/cpus=2,threads=1,free=78107032,total=271482880
[junit4:junit4] 2> NOTE: All tests run in this JVM: [LeaderElectionIntegrationTest, TestConfig, ReturnFieldsTest, CopyFieldTest, SynonymTokenizerTest, TestReplicationHandler, TestStressRecovery, TestFoldingMultitermQuery, ExternalFileFieldSortTest, ZkCLITest, BadIndexSchemaTest, AnalysisAfterCoreReloadTest, TestWriterPerf, PluginInfoTest, TestGroupingSearch, TestIndexingPerformance, TestArbitraryIndexDir, MBeansHandlerTest, SignatureUpdateProcessorFactoryTest, TestRTGBase, SuggesterWFSTTest, UpdateParamsTest, TestComponentsName, ResponseLogComponentTest, TestFunctionQuery, TestSolrIndexConfig, DebugComponentTest, SpellCheckComponentTest, PeerSyncTest, MinimalSchemaTest, TestOmitPositions, TimeZoneUtilsTest, TestRandomFaceting, TestIndexSearcher, TestLRUCache, UpdateRequestProcessorFactoryTest, IndexBasedSpellCheckerTest, MoreLikeThisHandlerTest, SampleTest, WordBreakSolrSpellCheckerTest, TestStressLucene, LoggingHandlerTest, TestSolrQueryParser, TestFastLRUCache, JsonLoaderTest, TestRealTimeGet, TestQueryTypes, TestDFRSimilarityFactory, TestQuerySenderListener, TestMultiCoreConfBootstrap, BinaryUpdateRequestHandlerTest, TestJmxMonitoredMap, SolrIndexConfigTest, ChaosMonkeyNothingIsSafeTest, TestLMDirichletSimilarityFactory, DocumentBuilderTest, DirectUpdateHandlerOptimizeTest, ChaosMonkeySafeLeaderTest, TestDefaultSimilarityFactory, PrimitiveFieldTypeTest, TestStressReorder, CollectionsAPIDistributedZkTest, DateFieldTest, TestSolrDeletionPolicy2, OverseerTest, MultiTermTest, BasicDistributedZkTest, FieldAnalysisRequestHandlerTest, FastVectorHighlighterTest, XmlUpdateRequestHandlerTest, SpellPossibilityIteratorTest, TestDistributedGrouping, DistributedQueryElevationComponentTest, TermVectorComponentTest, OutputWriterTest, TestPartialUpdateDeduplication, NoCacheHeaderTest, IndexSchemaRuntimeFieldTest, QueryEqualityTest, CoreAdminHandlerTest, TestDocumentBuilder, IndexReaderFactoryTest, TestRangeQuery, SpatialFilterTest, TestCodecSupport, TestCoreContainer, CurrencyFieldTest, IndexSchemaTest, SortByFunctionTest, TestSuggestSpellingConverter, SuggesterTest, TestWordDelimiterFilterFactory, BadComponentTest, TestSolrCoreProperties, TestUtils, DefaultValueUpdateProcessorTest, BasicDistributedZk2Test, OverseerCollectionProcessorTest, TestBinaryField, TestFastWriter, RecoveryZkTest]
[junit4:junit4] Completed in 81.51s, 1 test, 1 failure <<< FAILURES!
[...truncated 439 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: 247 suites, 1032 tests, 1 failure, 14 ignored (9 assumptions)
Total time: 48 minutes 59 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Description set: Java: 32bit/jdk1.7.0_10 -server -XX:+UseConcMarkSweepGC
Email was triggered for: Failure
Sending email for trigger: Failure