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/08/20 02:02:04 UTC
[JENKINS] Lucene-Solr-trunk-Linux (64bit/jdk1.7.0_25) - Build #
7085 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/7085/
Java: 64bit/jdk1.7.0_25 -XX:-UseCompressedOops -XX:+UseParallelGC
1 tests failed.
REGRESSION: org.apache.solr.schema.TestCloudManagedSchemaAddField.testDistribSearch
Error Message:
Max retry count 20 exceeded after 262 ms. QUERY FAILED: xpath=/response/lst[@name='responseHeader']/int[@name='status'][.='0'] request=/schema/fields/newfield17?wt=xml response=<?xml version="1.0" encoding="UTF-8"?> <response> <lst name="responseHeader"> <int name="status">404</int> <int name="QTime">0</int> </lst> <lst name="error"> <str name="msg">Field 'newfield17' not found.</str> <int name="code">404</int> </lst> </response>
Stack Trace:
java.lang.AssertionError: Max retry count 20 exceeded after 262 ms. QUERY FAILED: xpath=/response/lst[@name='responseHeader']/int[@name='status'][.='0'] request=/schema/fields/newfield17?wt=xml response=<?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader">
<int name="status">404</int>
<int name="QTime">0</int>
</lst>
<lst name="error">
<str name="msg">Field 'newfield17' not found.</str>
<int name="code">404</int>
</lst>
</response>
at __randomizedtesting.SeedInfo.seed([122D0A53110FA25B:93CB844B6650C267]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.schema.TestCloudManagedSchemaAddField.doTest(TestCloudManagedSchemaAddField.java:127)
at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:835)
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:606)
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:724)
Build Log:
[...truncated 10342 lines...]
[junit4] Suite: org.apache.solr.schema.TestCloudManagedSchemaAddField
[junit4] 2> 1725820 T3755 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /
[junit4] 2> 1725824 T3755 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4] 2> Creating dataDir: /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./solrtest-TestCloudManagedSchemaAddField-1376956840986
[junit4] 2> 1725825 T3755 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 2> 1725825 T3756 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server
[junit4] 2> 1725925 T3755 oasc.ZkTestServer.run start zk server on port:51971
[junit4] 2> 1725927 T3755 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 1726282 T3762 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1e3ce9ce name:ZooKeeperConnection Watcher:127.0.0.1:51971 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1726282 T3755 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 1726283 T3755 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 1726341 T3755 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 1726363 T3764 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@2d1a7721 name:ZooKeeperConnection Watcher:127.0.0.1:51971/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1726363 T3755 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 1726364 T3755 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4] 2> 1726408 T3755 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4] 2> 1726430 T3755 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4] 2> 1726452 T3755 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4] 2> 1726474 T3755 oasc.AbstractZkTestCase.putConfig put /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig-managed-schema.xml to /configs/conf1/solrconfig.xml
[junit4] 2> 1726475 T3755 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 1726541 T3755 oasc.AbstractZkTestCase.putConfig put /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4] 2> 1726542 T3755 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4] 2> 1726814 T3755 oasc.AbstractZkTestCase.putConfig put /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1726815 T3755 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1727052 T3755 oasc.AbstractZkTestCase.putConfig put /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4] 2> 1727053 T3755 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
[junit4] 2> 1727086 T3755 oasc.AbstractZkTestCase.putConfig put /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4] 2> 1727087 T3755 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
[junit4] 2> 1727108 T3755 oasc.AbstractZkTestCase.putConfig put /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4] 2> 1727109 T3755 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
[junit4] 2> 1727304 T3755 oasc.AbstractZkTestCase.putConfig put /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4] 2> 1727305 T3755 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
[junit4] 2> 1727339 T3755 oasc.AbstractZkTestCase.putConfig put /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1727340 T3755 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1727364 T3755 oasc.AbstractZkTestCase.putConfig put /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4] 2> 1727365 T3755 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
[junit4] 2> 1727553 T3755 oasc.AbstractZkTestCase.putConfig put /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4] 2> 1727554 T3755 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
[junit4] 2> 1727678 T3755 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1727681 T3755 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:47337
[junit4] 2> 1727682 T3755 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 1727683 T3755 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1727683 T3755 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ../../../../../../../../../../var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.schema.TestCloudManagedSchemaAddField-controljetty-1376956842769
[junit4] 2> 1727684 T3755 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../../var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.schema.TestCloudManagedSchemaAddField-controljetty-1376956842769/'
[junit4] 2> 1727709 T3755 oasc.ConfigSolr.fromFile Loading container configuration from /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/../../../../../../../../../../var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.schema.TestCloudManagedSchemaAddField-controljetty-1376956842769/solr.xml
[junit4] 2> 1727742 T3755 oasc.CoreContainer.<init> New CoreContainer 1922300843
[junit4] 2> 1727743 T3755 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=../../../../../../../../../../var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.schema.TestCloudManagedSchemaAddField-controljetty-1376956842769/]
[junit4] 2> 1727743 T3755 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 120000
[junit4] 2> 1727744 T3755 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 1727744 T3755 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 1727744 T3755 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 1727744 T3755 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 1727745 T3755 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 1727745 T3755 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 1727745 T3755 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 1727745 T3755 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 1727746 T3755 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=120000&connTimeout=15000&retry=false
[junit4] 2> 1727749 T3755 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:51971/solr
[junit4] 2> 1727749 T3755 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 1727750 T3755 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 1727775 T3775 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6a579efe name:ZooKeeperConnection Watcher:127.0.0.1:51971 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1727775 T3755 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 1727797 T3755 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=500&maxConnectionsPerHost=16&socketTimeout=120000&connTimeout=15000
[junit4] 2> 1727802 T3755 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 1727828 T3777 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6532d3cf name:ZooKeeperConnection Watcher:127.0.0.1:51971/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1727828 T3755 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 1727853 T3755 oascc.SolrZkClient.makePath makePath: /overseer/queue
[junit4] 2> 1727897 T3755 oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work
[junit4] 2> 1727920 T3755 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 1727942 T3755 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:47337_
[junit4] 2> 1727963 T3755 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:47337_
[junit4] 2> 1727987 T3755 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4] 2> 1728074 T3755 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4] 2> 1728097 T3755 oasc.Overseer.start Overseer (id=90240243530989571-127.0.0.1:47337_-n_0000000000) starting
[junit4] 2> 1728164 T3755 oascc.SolrZkClient.makePath makePath: /overseer/queue-work
[junit4] 2> 1728209 T3779 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
[junit4] 2> 1728209 T3755 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4] 2> 1728231 T3755 oascc.SolrZkClient.makePath makePath: /aliases.json
[junit4] 2> 1728253 T3755 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 1728257 T3778 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4] 2> 1728262 T3780 oasc.ZkController.publish publishing core=collection1 state=down
[junit4] 2> 1728262 T3780 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 1728594 T3780 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 1729762 T3778 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1729763 T3778 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4] 2> "operation":"state",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "numShards":"1",
[junit4] 2> "shard":null,
[junit4] 2> "roles":null,
[junit4] 2> "state":"down",
[junit4] 2> "shard_state":"active",
[junit4] 2> "core":"collection1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "shard_range":null,
[junit4] 2> "node_name":"127.0.0.1:47337_",
[junit4] 2> "base_url":"http://127.0.0.1:47337"}
[junit4] 2> 1729763 T3778 oasc.Overseer$ClusterStateUpdater.createCollection Create collection control_collection with shards [shard1]
[junit4] 2> 1729764 T3778 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1
[junit4] 2> 1729874 T3777 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 1730595 T3780 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
[junit4] 2> 1730595 T3780 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ../../../../../../../../../../var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.schema.TestCloudManagedSchemaAddField-controljetty-1376956842769/collection1
[junit4] 2> 1730596 T3780 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection
[junit4] 2> 1730597 T3780 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 1730597 T3780 oasc.ZkController.readConfigName Load collection config from:/collections/control_collection
[junit4] 2> 1730599 T3780 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../../var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.schema.TestCloudManagedSchemaAddField-controljetty-1376956842769/collection1/'
[junit4] 2> 1730600 T3780 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-controljetty-1376956842769/collection1/lib/README' to classloader
[junit4] 2> 1730601 T3780 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-controljetty-1376956842769/collection1/lib/classes/' to classloader
[junit4] 2> 1730635 T3780 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 1730660 T3780 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1730661 T3780 oass.ManagedIndexSchemaFactory.create The schema is configured as managed, but managed schema resource managed-schema not found - loading non-managed schema schema.xml instead
[junit4] 2> 1730663 T3780 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 1730668 T3780 oass.IndexSchema.readSchema [null] Schema name=test
[junit4] 2> 1730968 T3780 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1730973 T3780 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 1730975 T3780 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1730990 T3780 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1730994 T3780 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1730997 T3780 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1730998 T3780 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1730999 T3780 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1730999 T3780 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1731000 T3780 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1731001 T3780 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1731306 T3780 oass.ManagedIndexSchema.persistManagedSchemaToZooKeeper Created and persisted managed schema znode at /configs/conf1/managed-schema
[junit4] 2> 1731308 T3780 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml.bak
[junit4] 2> 1731564 T3780 oass.ManagedIndexSchemaFactory.zkUgradeToManagedSchema After upgrading to managed schema in ZooKeeper, renamed the non-managed schema /configs/conf1/schema.xml to /configs/conf1/schema.xml.bak
[junit4] 2> 1731564 T3780 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory
[junit4] 2> 1731564 T3780 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ../../../../../../../../../../var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.schema.TestCloudManagedSchemaAddField-controljetty-1376956842769/collection1/, dataDir=/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-controljetty-1376956842769/collection1/data/
[junit4] 2> 1731565 T3780 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 1731566 T3780 oasc.CachingDirectoryFactory.get return new directory for /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-controljetty-1376956842769/collection1/data
[junit4] 2> 1731566 T3780 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-controljetty-1376956842769/collection1/data/index/
[junit4] 2> 1731567 T3780 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-controljetty-1376956842769/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 1731567 T3780 oasc.CachingDirectoryFactory.get return new directory for /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-controljetty-1376956842769/collection1/data/index
[junit4] 2> 1731568 T3780 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=12, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4473928334260807]
[junit4] 2> 1732007 T3780 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(org.apache.lucene.store.MMapDirectory@/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-controljetty-1376956842769/collection1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3ea04ddb; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 1732008 T3780 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1732008 T3780 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1732009 T3780 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 1732009 T3780 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 1732009 T3780 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 1732009 T3780 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 1732009 T3780 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 1732010 T3780 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 1732012 T3780 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1732014 T3780 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 1732014 T3780 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1732015 T3780 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=24, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=10.521484375, floorSegmentMB=0.375, forceMergeDeletesPctAllowed=20.665788716034058, segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.15720542841278518
[junit4] 2> 1732016 T3780 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(org.apache.lucene.store.MMapDirectory@/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-controljetty-1376956842769/collection1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3ea04ddb; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 1732016 T3780 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1732016 T3780 oass.SolrIndexSearcher.<init> Opening Searcher@12d5e91b main
[junit4] 2> 1732018 T3780 oass.ZkIndexSchemaReader.createSchemaWatcher Creating ZooKeeper watch for the managed schema at /configs/conf1/managed-schema ...
[junit4] 2> 1732019 T3781 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@12d5e91b main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 1732019 T3780 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 1732020 T3780 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:47337 collection:control_collection shard:shard1
[junit4] 2> 1732020 T3780 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=10000&maxConnectionsPerHost=20&connTimeout=15000&socketTimeout=30000&retry=false
[junit4] 2> 1732023 T3780 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/shard1/election
[junit4] 2> 1732197 T3780 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard1
[junit4] 2> 1732242 T3780 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4] 2> 1732242 T3780 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4] 2> 1732242 T3780 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:47337/collection1/
[junit4] 2> 1732243 T3780 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4] 2> 1732243 T3780 oasc.SyncStrategy.syncToMe http://127.0.0.1:47337/collection1/ has no replicas
[junit4] 2> 1732243 T3780 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:47337/collection1/ shard1
[junit4] 2> 1732243 T3780 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/shard1
[junit4] 2> 1733066 T3778 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1733552 T3777 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 1733633 T3780 oasc.ZkController.register We are http://127.0.0.1:47337/collection1/ and leader is http://127.0.0.1:47337/collection1/
[junit4] 2> 1733633 T3780 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:47337
[junit4] 2> 1733634 T3780 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4] 2> 1733634 T3780 oasc.ZkController.publish publishing core=collection1 state=active
[junit4] 2> 1733634 T3780 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 1733653 T3780 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1733654 T3755 oass.SolrDispatchFilter.init user.dir=/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4] 2> 1733654 T3755 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 1733655 T3755 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 1733657 T3755 oascsi.HttpClientUtil.createClient Creating new http client, config:
[junit4] 2> 1733658 T3755 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 1733695 T3784 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@3ccbaaf5 name:ZooKeeperConnection Watcher:127.0.0.1:51971/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1733695 T3755 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 1733697 T3755 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 1733699 T3755 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:true cause connection loss:true
[junit4] 2> 1733756 T3755 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1733757 T3755 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:60669
[junit4] 2> 1733758 T3755 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 1733759 T3755 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1733759 T3755 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty1-1376956848860
[junit4] 2> 1733759 T3755 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty1-1376956848860/'
[junit4] 2> 1733770 T3755 oasc.ConfigSolr.fromFile Loading container configuration from /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty1-1376956848860/solr.xml
[junit4] 2> 1733801 T3755 oasc.CoreContainer.<init> New CoreContainer 1188067447
[junit4] 2> 1733801 T3755 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty1-1376956848860/]
[junit4] 2> 1733802 T3755 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 120000
[junit4] 2> 1733803 T3755 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 1733803 T3755 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 1733803 T3755 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 1733803 T3755 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 1733804 T3755 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 1733804 T3755 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 1733804 T3755 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 1733804 T3755 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 1733805 T3755 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=120000&connTimeout=15000&retry=false
[junit4] 2> 1733808 T3755 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:51971/solr
[junit4] 2> 1733808 T3755 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 1733809 T3755 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 1733842 T3795 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@a3908e5 name:ZooKeeperConnection Watcher:127.0.0.1:51971 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1733842 T3755 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 1733864 T3755 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=500&maxConnectionsPerHost=16&socketTimeout=120000&connTimeout=15000
[junit4] 2> 1733868 T3755 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 1733886 T3797 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@25ec3b20 name:ZooKeeperConnection Watcher:127.0.0.1:51971/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1733886 T3755 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 1733932 T3755 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 1734935 T3755 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60669_
[junit4] 2> 1734997 T3755 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:60669_
[junit4] 2> 1735020 T3797 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4] 2> 1735020 T3784 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4] 2> 1735020 T3777 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4] 2> 1735021 T3777 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1735045 T3798 oasc.ZkController.publish publishing core=collection1 state=down
[junit4] 2> 1735046 T3798 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 1735063 T3798 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 1735100 T3778 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1735100 T3778 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4] 2> "operation":"state",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "numShards":"1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "roles":null,
[junit4] 2> "state":"active",
[junit4] 2> "shard_state":"active",
[junit4] 2> "core":"collection1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "shard_range":null,
[junit4] 2> "node_name":"127.0.0.1:47337_",
[junit4] 2> "base_url":"http://127.0.0.1:47337"}
[junit4] 2> 1735142 T3778 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "numShards":"4",
[junit4] 2> "shard":null,
[junit4] 2> "roles":null,
[junit4] 2> "state":"down",
[junit4] 2> "shard_state":"active",
[junit4] 2> "core":"collection1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard_range":null,
[junit4] 2> "node_name":"127.0.0.1:60669_",
[junit4] 2> "base_url":"http://127.0.0.1:60669"}
[junit4] 2> 1735142 T3778 oasc.Overseer$ClusterStateUpdater.createCollection Create collection collection1 with shards [shard1, shard2, shard3, shard4]
[junit4] 2> 1735143 T3778 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1
[junit4] 2> 1735621 T3777 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1735621 T3797 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1735621 T3784 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1736064 T3798 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
[junit4] 2> 1736064 T3798 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty1-1376956848860/collection1
[junit4] 2> 1736064 T3798 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4] 2> 1736065 T3798 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 1736065 T3798 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4] 2> 1736066 T3798 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty1-1376956848860/collection1/'
[junit4] 2> 1736067 T3798 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty1-1376956848860/collection1/lib/README' to classloader
[junit4] 2> 1736067 T3798 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty1-1376956848860/collection1/lib/classes/' to classloader
[junit4] 2> 1736094 T3798 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 1736119 T3798 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1736121 T3798 oass.IndexSchema.readSchema Reading Solr Schema from managed-schema
[junit4] 2> 1736127 T3798 oass.IndexSchema.readSchema [null] Schema name=test
[junit4] 2> 1736429 T3798 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1736433 T3798 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 1736435 T3798 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1736438 T3798 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1736441 T3798 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1736449 T3798 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1736450 T3798 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1736450 T3798 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1736450 T3798 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1736451 T3798 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1736451 T3798 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1736454 T3798 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory
[junit4] 2> 1736455 T3798 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty1-1376956848860/collection1/, dataDir=/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty1-1376956848860/collection1/data/
[junit4] 2> 1736455 T3798 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 1736455 T3798 oasc.CachingDirectoryFactory.get return new directory for /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty1-1376956848860/collection1/data
[junit4] 2> 1736455 T3798 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty1-1376956848860/collection1/data/index/
[junit4] 2> 1736456 T3798 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty1-1376956848860/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 1736456 T3798 oasc.CachingDirectoryFactory.get return new directory for /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty1-1376956848860/collection1/data/index
[junit4] 2> 1736456 T3798 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=12, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4473928334260807]
[junit4] 2> 1736970 T3798 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(org.apache.lucene.store.MMapDirectory@/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty1-1376956848860/collection1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@22ab21be; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 1736970 T3798 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1736971 T3798 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1736972 T3798 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 1736972 T3798 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 1736972 T3798 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 1736973 T3798 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 1736973 T3798 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 1736973 T3798 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 1736977 T3798 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1736980 T3798 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 1736981 T3798 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1736981 T3798 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=24, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=10.521484375, floorSegmentMB=0.375, forceMergeDeletesPctAllowed=20.665788716034058, segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.15720542841278518
[junit4] 2> 1736983 T3798 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(org.apache.lucene.store.MMapDirectory@/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty1-1376956848860/collection1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@22ab21be; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 1736984 T3798 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1736984 T3798 oass.SolrIndexSearcher.<init> Opening Searcher@42066a7d main
[junit4] 2> 1736984 T3798 oass.ZkIndexSchemaReader.createSchemaWatcher Creating ZooKeeper watch for the managed schema at /configs/conf1/managed-schema ...
[junit4] 2> 1736987 T3798 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 1736987 T3799 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@42066a7d main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 1736987 T3798 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:60669 collection:collection1 shard:shard1
[junit4] 2> 1736988 T3798 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=10000&maxConnectionsPerHost=20&connTimeout=15000&socketTimeout=30000&retry=false
[junit4] 2> 1736992 T3798 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election
[junit4] 2> 1737108 T3798 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard1
[junit4] 2> 1737153 T3798 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4] 2> 1737153 T3798 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4] 2> 1737154 T3798 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:60669/collection1/
[junit4] 2> 1737154 T3798 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4] 2> 1737154 T3798 oasc.SyncStrategy.syncToMe http://127.0.0.1:60669/collection1/ has no replicas
[junit4] 2> 1737155 T3798 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:60669/collection1/ shard1
[junit4] 2> 1737155 T3798 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4] 2> 1737220 T3778 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1737586 T3784 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1737586 T3797 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1737586 T3777 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1737642 T3798 oasc.ZkController.register We are http://127.0.0.1:60669/collection1/ and leader is http://127.0.0.1:60669/collection1/
[junit4] 2> 1737643 T3798 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:60669
[junit4] 2> 1737643 T3798 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4] 2> 1737643 T3798 oasc.ZkController.publish publishing core=collection1 state=active
[junit4] 2> 1737643 T3798 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 1737664 T3798 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1737665 T3755 oass.SolrDispatchFilter.init user.dir=/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4] 2> 1737665 T3755 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 1737666 T3755 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 1737726 T3755 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1737728 T3755 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:36300
[junit4] 2> 1737729 T3755 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 1737729 T3755 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1737729 T3755 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty2-1376956852829
[junit4] 2> 1737729 T3755 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty2-1376956852829/'
[junit4] 2> 1737740 T3755 oasc.ConfigSolr.fromFile Loading container configuration from /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty2-1376956852829/solr.xml
[junit4] 2> 1737779 T3755 oasc.CoreContainer.<init> New CoreContainer 340268281
[junit4] 2> 1737780 T3755 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty2-1376956852829/]
[junit4] 2> 1737781 T3755 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 120000
[junit4] 2> 1737781 T3755 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 1737781 T3755 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 1737782 T3755 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 1737782 T3755 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 1737782 T3755 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 1737783 T3755 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 1737783 T3755 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 1737783 T3755 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 1737783 T3755 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=120000&connTimeout=15000&retry=false
[junit4] 2> 1737786 T3755 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:51971/solr
[junit4] 2> 1737787 T3755 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 1737787 T3755 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 1737808 T3811 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@c833d3d name:ZooKeeperConnection Watcher:127.0.0.1:51971 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1737808 T3755 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 1737830 T3755 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=500&maxConnectionsPerHost=16&socketTimeout=120000&connTimeout=15000
[junit4] 2> 1737833 T3755 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 1737853 T3813 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@4b6095c1 name:ZooKeeperConnection Watcher:127.0.0.1:51971/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1737853 T3755 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 1737898 T3755 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 1738901 T3755 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:36300_
[junit4] 2> 1738986 T3755 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:36300_
[junit4] 2> 1739008 T3797 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1739009 T3784 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4] 2> 1739009 T3777 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4] 2> 1739009 T3784 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1739010 T3813 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4] 2> 1739010 T3777 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1739010 T3797 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4] 2> 1739034 T3814 oasc.ZkController.publish publishing core=collection1 state=down
[junit4] 2> 1739034 T3814 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 1739052 T3814 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 1739143 T3778 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1739144 T3778 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "numShards":"4",
[junit4] 2> "shard":"shard1",
[junit4] 2> "roles":null,
[junit4] 2> "state":"active",
[junit4] 2> "shard_state":"active",
[junit4] 2> "core":"collection1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard_range":null,
[junit4] 2> "node_name":"127.0.0.1:60669_",
[junit4] 2> "base_url":"http://127.0.0.1:60669"}
[junit4] 2> 1739186 T3778 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "core_node_name":"core_node2",
[junit4] 2> "numShards":"4",
[junit4] 2> "shard":null,
[junit4] 2> "roles":null,
[junit4] 2> "state":"down",
[junit4] 2> "shard_state":"active",
[junit4] 2> "core":"collection1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard_range":null,
[junit4] 2> "node_name":"127.0.0.1:36300_",
[junit4] 2> "base_url":"http://127.0.0.1:36300"}
[junit4] 2> 1739187 T3778 oasc.Overseer$ClusterStateUpdater.updateState Collection already exists with numShards=4
[junit4] 2> 1739187 T3778 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard4
[junit4] 2> 1739537 T3797 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1739537 T3813 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1739537 T3784 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1739537 T3777 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1740053 T3814 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
[junit4] 2> 1740053 T3814 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty2-1376956852829/collection1
[junit4] 2> 1740053 T3814 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4] 2> 1740054 T3814 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 1740054 T3814 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4] 2> 1740055 T3814 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty2-1376956852829/collection1/'
[junit4] 2> 1740056 T3814 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty2-1376956852829/collection1/lib/README' to classloader
[junit4] 2> 1740056 T3814 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty2-1376956852829/collection1/lib/classes/' to classloader
[junit4] 2> 1740092 T3814 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 1740119 T3814 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1740120 T3814 oass.IndexSchema.readSchema Reading Solr Schema from managed-schema
[junit4] 2> 1740126 T3814 oass.IndexSchema.readSchema [null] Schema name=test
[junit4] 2> 1740437 T3814 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1740441 T3814 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 1740443 T3814 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1740449 T3814 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1740452 T3814 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1740460 T3814 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1740461 T3814 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1740461 T3814 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1740461 T3814 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1740462 T3814 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1740462 T3814 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1740464 T3814 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory
[junit4] 2> 1740465 T3814 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty2-1376956852829/collection1/, dataDir=/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty2-1376956852829/collection1/data/
[junit4] 2> 1740465 T3814 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 1740465 T3814 oasc.CachingDirectoryFactory.get return new directory for /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty2-1376956852829/collection1/data
[junit4] 2> 1740466 T3814 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty2-1376956852829/collection1/data/index/
[junit4] 2> 1740466 T3814 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty2-1376956852829/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 1740466 T3814 oasc.CachingDirectoryFactory.get return new directory for /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty2-1376956852829/collection1/data/index
[junit4] 2> 1740467 T3814 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=12, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4473928334260807]
[junit4] 2> 1740943 T3814 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(org.apache.lucene.store.MMapDirectory@/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty2-1376956852829/collection1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@79b1f4c5; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 1740944 T3814 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1740945 T3814 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1740946 T3814 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 1740946 T3814 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 1740946 T3814 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 1740947 T3814 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 1740947 T3814 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 1740947 T3814 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 1740951 T3814 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1740954 T3814 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 1740954 T3814 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1740955 T3814 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=24, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=10.521484375, floorSegmentMB=0.375, forceMergeDeletesPctAllowed=20.665788716034058, segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.15720542841278518
[junit4] 2> 1740956 T3814 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(org.apache.lucene.store.MMapDirectory@/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty2-1376956852829/collection1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@79b1f4c5; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 1740956 T3814 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1740956 T3814 oass.SolrIndexSearcher.<init> Opening Searcher@2c15d45a main
[junit4] 2> 1740957 T3814 oass.ZkIndexSchemaReader.createSchemaWatcher Creating ZooKeeper watch for the managed schema at /configs/conf1/managed-schema ...
[junit4] 2> 1740958 T3815 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2c15d45a main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 1740958 T3814 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 1740958 T3814 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:36300 collection:collection1 shard:shard4
[junit4] 2> 1740959 T3814 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=10000&maxConnectionsPerHost=20&connTimeout=15000&socketTimeout=30000&retry=false
[junit4] 2> 1740962 T3814 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard4/election
[junit4] 2> 1741064 T3814 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard4
[junit4] 2> 1741108 T3814 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4] 2> 1741108 T3814 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4] 2> 1741109 T3814 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:36300/collection1/
[junit4] 2> 1741109 T3814 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4] 2> 1741109 T3814 oasc.SyncStrategy.syncToMe http://127.0.0.1:36300/collection1/ has no replicas
[junit4] 2> 1741109 T3814 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:36300/collection1/ shard4
[junit4] 2> 1741109 T3814 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard4
[junit4] 2> 1741109 T3778 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1741219 T3797 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1741219 T3784 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1741219 T3777 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1741219 T3813 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1742743 T3778 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1744088 T3759 oazsp.FileTxnLog.commit WARN fsync-ing the write ahead log in SyncThread:0 took 1344ms which will adversely effect operation latency. See the ZooKeeper troubleshooting guide
[junit4] 2> 1745450 T3797 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1745450 T3784 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1745450 T3777 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1745450 T3813 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1745479 T3814 oasc.ZkController.register We are http://127.0.0.1:36300/collection1/ and leader is http://127.0.0.1:36300/collection1/
[junit4] 2> 1745479 T3814 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:36300
[junit4] 2> 1745479 T3814 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4] 2> 1745479 T3814 oasc.ZkController.publish publishing core=collection1 state=active
[junit4] 2> 1745480 T3814 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 1745508 T3814 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1745509 T3755 oass.SolrDispatchFilter.init user.dir=/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4] 2> 1745509 T3755 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 1745510 T3755 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 1745569 T3755 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1745571 T3755 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:40186
[junit4] 2> 1745572 T3755 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 1745572 T3755 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1745573 T3755 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty3-1376956860673
[junit4] 2> 1745573 T3755 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty3-1376956860673/'
[junit4] 2> 1745583 T3755 oasc.ConfigSolr.fromFile Loading container configuration from /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty3-1376956860673/solr.xml
[junit4] 2> 1745615 T3755 oasc.CoreContainer.<init> New CoreContainer 1807098297
[junit4] 2> 1745616 T3755 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty3-1376956860673/]
[junit4] 2> 1745616 T3755 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 120000
[junit4] 2> 1745617 T3755 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 1745617 T3755 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 1745617 T3755 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 1745617 T3755 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 1745618 T3755 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 1745618 T3755 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 1745618 T3755 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 1745618 T3755 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 1745619 T3755 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=120000&connTimeout=15000&retry=false
[junit4] 2> 1745621 T3755 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:51971/solr
[junit4] 2> 1745622 T3755 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 1745622 T3755 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 1745641 T3827 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@78ad0af3 name:ZooKeeperConnection Watcher:127.0.0.1:51971 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1745641 T3755 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 1745663 T3755 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=500&maxConnectionsPerHost=16&socketTimeout=120000&connTimeout=15000
[junit4] 2> 1745666 T3755 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 1745686 T3829 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@18987b9c name:ZooKeeperConnection Watcher:127.0.0.1:51971/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1745686 T3755 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 1745732 T3755 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 1746735 T3755 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:40186_
[junit4] 2> 1746797 T3755 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:40186_
[junit4] 2> 1746819 T3797 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1746820 T3813 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1746820 T3784 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4] 2> 1746820 T3777 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4] 2> 1746820 T3777 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 4)
[junit4] 2> 1746820 T3829 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4] 2> 1746820 T3784 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 4)
[junit4] 2> 1746841 T3813 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4] 2> 1746841 T3797 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4] 2> 1746845 T3830 oasc.ZkController.publish publishing core=collection1 state=down
[junit4] 2> 1746845 T3830 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 1746863 T3830 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 1747010 T3778 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1747011 T3778 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "core_node_name":"core_node2",
[junit4] 2> "numShards":"4",
[junit4] 2> "shard":"shard4",
[junit4] 2> "roles":null,
[junit4] 2> "state":"active",
[junit4] 2> "shard_state":"active",
[junit4] 2> "core":"collection1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard_range":null,
[junit4] 2> "node_name":"127.0.0.1:36300_",
[junit4] 2> "base_url":"http://127.0.0.1:36300"}
[junit4] 2> 1747064 T3778 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "core_node_name":"core_node3",
[junit4] 2> "numShards":"4",
[junit4] 2> "shard":null,
[junit4] 2> "roles":null,
[junit4] 2> "state":"down",
[junit4] 2> "shard_state":"active",
[junit4] 2> "core":"collection1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard_range":null,
[junit4] 2> "node_name":"127.0.0.1:40186_",
[junit4] 2> "base_url":"http://127.0.0.1:40186"}
[junit4] 2> 1747065 T3778 oasc.Overseer$ClusterStateUpdater.updateState Collection already exists with numShards=4
[junit4] 2> 1747065 T3778 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard2
[junit4] 2> 1747440 T3829 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
[junit4] 2> 1747440 T3813 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
[junit4] 2> 1747440 T3784 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
[junit4] 2> 1747440 T3797 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
[junit4] 2> 1747440 T3777 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
[junit4] 2> 1747864 T3830 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
[junit4] 2> 1747864 T3830 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty3-1376956860673/collection1
[junit4] 2> 1747864 T3830 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4] 2> 1747865 T3830 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 1747865 T3830 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4] 2> 1747866 T3830 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty3-1376956860673/collection1/'
[junit4] 2> 1747867 T3830 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty3-1376956860673/collection1/lib/README' to classloader
[junit4] 2> 1747867 T3830 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty3-1376956860673/collection1/lib/classes/' to classloader
[junit4] 2> 1747897 T3830 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 1747925 T3830 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1747926 T3830 oass.IndexSchema.readSchema Reading Solr Schema from managed-schema
[junit4] 2> 1747933 T3830 oass.IndexSchema.readSchema [null] Schema name=test
[junit4] 2> 1748242 T3830 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1748247 T3830 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 1748249 T3830 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1748252 T3830 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1748255 T3830 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1748263 T3830 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1748264 T3830 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1748264 T3830 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1748264 T3830 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1748265 T3830 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1748265 T3830 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1748268 T3830 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory
[junit4] 2> 1748268 T3830 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty3-1376956860673/collection1/, dataDir=/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty3-1376956860673/collection1/data/
[junit4] 2> 1748268 T3830 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 1748269 T3830 oasc.CachingDirectoryFactory.get return new directory for /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty3-1376956860673/collection1/data
[junit4] 2> 1748269 T3830 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty3-1376956860673/collection1/data/index/
[junit4] 2> 1748269 T3830 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty3-1376956860673/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 1748269 T3830 oasc.CachingDirectoryFactory.get return new directory for /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty3-1376956860673/collection1/data/index
[junit4] 2> 1748270 T3830 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=12, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4473928334260807]
[junit4] 2> 1748714 T3830 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(org.apache.lucene.store.MMapDirectory@/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty3-1376956860673/collection1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@254a043; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 1748714 T3830 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1748715 T3830 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1748715 T3830 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 1748715 T3830 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 1748716 T3830 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 1748716 T3830 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 1748716 T3830 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 1748716 T3830 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 1748718 T3830 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1748720 T3830 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 1748721 T3830 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1748721 T3830 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=24, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=10.521484375, floorSegmentMB=0.375, forceMergeDeletesPctAllowed=20.665788716034058, segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.15720542841278518
[junit4] 2> 1748722 T3830 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(org.apache.lucene.store.MMapDirectory@/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty3-1376956860673/collection1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@254a043; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 1748722 T3830 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1748723 T3830 oass.SolrIndexSearcher.<init> Opening Searcher@60487060 main
[junit4] 2> 1748723 T3830 oass.ZkIndexSchemaReader.createSchemaWatcher Creating ZooKeeper watch for the managed schema at /configs/conf1/managed-schema ...
[junit4] 2> 1748724 T3831 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@60487060 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 1748724 T3830 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 1748724 T3830 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:40186 collection:collection1 shard:shard2
[junit4] 2> 1748724 T3830 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=10000&maxConnectionsPerHost=20&connTimeout=15000&socketTimeout=30000&retry=false
[junit4] 2> 1748727 T3830 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard2/election
[junit4] 2> 1748819 T3830 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard2
[junit4] 2> 1748863 T3830 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4] 2> 1748864 T3830 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4] 2> 1748864 T3830 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:40186/collection1/
[junit4] 2> 1748864 T3830 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4] 2> 1748864 T3830 oasc.SyncStrategy.syncToMe http://127.0.0.1:40186/collection1/ has no replicas
[junit4] 2> 1748864 T3830 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:40186/collection1/ shard2
[junit4] 2> 1748865 T3830 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard2
[junit4] 2> 1748999 T3778 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1749326 T3797 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
[junit4] 2> 1749326 T3784 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 4)
[junit4] 2> 1749326 T3813 oascc.ZkStateReader$2.process A cluster state change: Watche
[...truncated too long message...]
1794050 T3755 oasc.CachingDirectoryFactory.closeCacheValue looking to close /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty8-1376956881090/collection1/data/index [CachedDir<<refCount=0;path=/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty8-1376956881090/collection1/data/index;done=false>>]
[junit4] 2> 1794051 T3755 oasc.CachingDirectoryFactory.close Closing directory: /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty8-1376956881090/collection1/data/index
[junit4] 2> 1794051 T3755 oasc.CachingDirectoryFactory.closeCacheValue looking to close /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty8-1376956881090/collection1/data [CachedDir<<refCount=0;path=/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty8-1376956881090/collection1/data;done=false>>]
[junit4] 2> 1794051 T3755 oasc.CachingDirectoryFactory.close Closing directory: /var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.schema.TestCloudManagedSchemaAddField-jetty8-1376956881090/collection1/data
[junit4] 2> 1794052 T3896 oascc.ZkStateReader$2.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 1794052 T3896 oascc.ZkStateReader$3.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 1794052 T3896 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1794052 T3896 oascc.ZkStateReader$2.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 1794202 T3755 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/,null}
[junit4] 2> 1794253 T3755 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
[junit4] 2> 1794255 T3755 oasc.ZkTestServer.send4LetterWord connecting to 127.0.0.1:51971 51971
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestCloudManagedSchemaAddField -Dtests.method=testDistribSearch -Dtests.seed=122D0A53110FA25B -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=es_HN -Dtests.timezone=Mideast/Riyadh87 -Dtests.file.encoding=UTF-8
[junit4] FAILURE 68.6s J1 | TestCloudManagedSchemaAddField.testDistribSearch <<<
[junit4] > Throwable #1: java.lang.AssertionError: Max retry count 20 exceeded after 262 ms. QUERY FAILED: xpath=/response/lst[@name='responseHeader']/int[@name='status'][.='0'] request=/schema/fields/newfield17?wt=xml response=<?xml version="1.0" encoding="UTF-8"?>
[junit4] > <response>
[junit4] > <lst name="responseHeader">
[junit4] > <int name="status">404</int>
[junit4] > <int name="QTime">0</int>
[junit4] > </lst>
[junit4] > <lst name="error">
[junit4] > <str name="msg">Field 'newfield17' not found.</str>
[junit4] > <int name="code">404</int>
[junit4] > </lst>
[junit4] > </response>
[junit4] > at __randomizedtesting.SeedInfo.seed([122D0A53110FA25B:93CB844B6650C267]:0)
[junit4] > at org.apache.solr.schema.TestCloudManagedSchemaAddField.doTest(TestCloudManagedSchemaAddField.java:127)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:835)
[junit4] > at java.lang.Thread.run(Thread.java:724)
[junit4] 2> 1794456 T3755 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 68647 T3754 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will linger awaiting termination of 2 leaked thread(s).
[junit4] 2> 1795352 T3914 oascc.ZkStateReader$2.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 1795352 T3914 oascc.ZkStateReader$3.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 1795352 T3914 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1)
[junit4] 2> 1795353 T3914 oascc.ZkStateReader$2.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> NOTE: test params are: codec=Lucene41, sim=DefaultSimilarity, locale=es_HN, timezone=Mideast/Riyadh87
[junit4] 2> NOTE: Linux 3.2.0-51-generic amd64/Oracle Corporation 1.7.0_25 (64-bit)/cpus=8,threads=1,free=178477008,total=423297024
[junit4] 2> NOTE: All tests run in this JVM: [TestFastLRUCache, DirectSolrConnectionTest, FileUtilsTest, TestStressRecovery, TestJmxIntegration, TestComponentsName, TestFiltering, RequestHandlersTest, SpellCheckCollatorTest, OutputWriterTest, TestClassNameShortening, TestIndexingPerformance, IndexSchemaRuntimeFieldTest, SolrRequestParserTest, TimeZoneUtilsTest, HdfsSyncSliceTest, MultiTermTest, SolrIndexConfigTest, DistanceFunctionTest, TestFastOutputStream, SpellCheckComponentTest, TestFoldingMultitermQuery, BasicZkTest, OpenCloseCoreStressTest, ConvertedLegacyTest, CoreAdminCreateDiscoverTest, DirectSolrSpellCheckerTest, TestSolr4Spatial, TestDistributedGrouping, TestZkChroot, TestFieldResource, CoreMergeIndexesAdminHandlerTest, SolrPluginUtilsTest, NumericFieldsTest, TestRecoveryHdfs, PingRequestHandlerTest, AlternateDirectoryTest, CustomCollectionTest, XmlUpdateRequestHandlerTest, HighlighterConfigTest, TestAnalyzedSuggestions, OpenExchangeRatesOrgProviderTest, TestRecovery, BadIndexSchemaTest, TestCodecSupport, AddBlockUpdateTest, TestFuzzyAnalyzedSuggestions, TestPartialUpdateDeduplication, ZkNodePropsTest, SolrXmlInZkTest, TestIBSimilarityFactory, HdfsUnloadDistributedZkTest, PathHierarchyTokenizerFactoryTest, CollectionsAPIDistributedZkTest, TestDFRSimilarityFactory, TestCSVLoader, SolrCoreCheckLockOnStartupTest, TestRTGBase, AliasIntegrationTest, RequiredFieldsTest, HardAutoCommitTest, TestReload, TestUniqueKeyFieldResource, SuggesterWFSTTest, ShardSplitTest, TestSchemaResource, ChaosMonkeySafeLeaderTest, NotRequiredUniqueKeyTest, StandardRequestHandlerTest, TestSolrCoreProperties, TestDefaultSearchFieldResource, HdfsRecoveryZkTest, SortByFunctionTest, LeaderElectionIntegrationTest, TestCollationField, BlockCacheTest, TestBinaryResponseWriter, RecoveryZkTest, TestRandomFaceting, TestRandomDVFaceting, TestFaceting, DistributedSpellCheckComponentTest, TestStressReorder, TestMultiCoreConfBootstrap, DistributedTermsComponentTest, TestCoreContainer, StatsComponentTest, PeerSyncTest, TestLazyCores, DirectUpdateHandlerTest, HighlighterTest, CurrencyFieldXmlFileTest, SimplePostToolTest, TestCoreDiscovery, SignatureUpdateProcessorFactoryTest, SuggesterTest, SchemaVersionSpecificBehaviorTest, FieldMutatingUpdateProcessorTest, TestWordDelimiterFilterFactory, DefaultValueUpdateProcessorTest, StatelessScriptUpdateProcessorFactoryTest, DocValuesMultiTest, TestSolrDeletionPolicy1, XsltUpdateRequestHandlerTest, IndexBasedSpellCheckerTest, DisMaxRequestHandlerTest, DocumentAnalysisRequestHandlerTest, PrimitiveFieldTypeTest, TestOmitPositions, TermsComponentTest, MoreLikeThisHandlerTest, TestSolrQueryParser, FastVectorHighlighterTest, IndexSchemaTest, JSONWriterTest, TestCSVResponseWriter, JsonLoaderTest, BinaryUpdateRequestHandlerTest, CoreContainerCoreInitFailuresTest, TestQuerySenderNoQuery, CopyFieldTest, TestSolrDeletionPolicy2, MinimalSchemaTest, TestPhraseSuggestions, SpellPossibilityIteratorTest, TestXIncludeConfig, EchoParamsTest, TestNumberUtils, TestBM25SimilarityFactory, TestFastWriter, TestJmxMonitoredMap, DateMathParserTest, PreAnalyzedFieldTest, PrimUtilsTest, DateFieldTest, SpellingQueryConverterTest, DOMUtilTest, RAMDirectoryFactoryTest, TestSolrJ, TestLRUCache, TestUtils, TestDocumentBuilder, SystemInfoHandlerTest, SolrTestCaseJ4Test, HdfsBasicDistributedZkTest, HdfsChaosMonkeySafeLeaderTest, HdfsCollectionsAPIDistributedZkTest, CachingDirectoryFactoryTest, QueryResultKeyTest, TestImplicitCoreProperties, TestInfoStreamLogging, TestReloadAndDeleteDocs, TestSolrXml, TestSolrXmlPersistence, TestCopyFieldCollectionResource, TestDynamicFieldCollectionResource, TestFieldCollectionResource, TestFieldTypeResource, TestManagedSchemaFieldResource, TestSchemaNameResource, TestSchemaSimilarityResource, TestSchemaVersionResource, TestCloudManagedSchemaAddField]
[junit4] Completed on J1 in 69.68s, 1 test, 1 failure <<< FAILURES!
[...truncated 34 lines...]
BUILD FAILED
/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:389: The following error occurred while executing this line:
/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:369: The following error occurred while executing this line:
/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:39: The following error occurred while executing this line:
/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:181: The following error occurred while executing this line:
/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:450: The following error occurred while executing this line:
/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1230: The following error occurred while executing this line:
/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:873: There were test failures: 322 suites, 1372 tests, 1 failure, 35 ignored (6 assumptions)
Total time: 47 minutes 0 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.7.0_25 -XX:-UseCompressedOops -XX:+UseParallelGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
[JENKINS] Lucene-Solr-trunk-Linux (64bit/ibm-j9-jdk7) - Build #
7086 - Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/7086/
Java: 64bit/ibm-j9-jdk7 -Xjit:exclude={org/apache/lucene/util/fst/FST.pack(IIF)Lorg/apache/lucene/util/fst/FST;}
6 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.OverseerTest
Error Message:
ERROR: SolrZkClient opens=169 closes=76
Stack Trace:
java.lang.AssertionError: ERROR: SolrZkClient opens=169 closes=76
at __randomizedtesting.SeedInfo.seed([96916576CEB213AA]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.SolrTestCaseJ4.endTrackingZkClients(SolrTestCaseJ4.java:342)
at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:134)
at sun.reflect.GeneratedMethodAccessor28.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
at java.lang.reflect.Method.invoke(Method.java:613)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:700)
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:780)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.OverseerTest
Error Message:
191 threads leaked from SUITE scope at org.apache.solr.cloud.OverseerTest: 1) Thread[id=1720, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 2) Thread[id=1893, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 3) Thread[id=1734, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 4) Thread[id=1876, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 5) Thread[id=1872, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 6) Thread[id=1742, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 7) Thread[id=1738, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 8) Thread[id=1865, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 9) Thread[id=1726, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 10) Thread[id=1809, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 11) Thread[id=1855, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 12) Thread[id=1836, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 13) Thread[id=1796, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 14) Thread[id=1871, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 15) Thread[id=1877, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 16) Thread[id=1722, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 17) Thread[id=1844, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 18) Thread[id=1851, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 19) Thread[id=1816, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 20) Thread[id=1804, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 21) Thread[id=1853, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 22) Thread[id=1762, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 23) Thread[id=1890, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 24) Thread[id=1817, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 25) Thread[id=1710, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 26) Thread[id=1782, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 27) Thread[id=1837, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 28) Thread[id=1852, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 29) Thread[id=1713, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 30) Thread[id=1826, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 31) Thread[id=1737, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 32) Thread[id=1820, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 33) Thread[id=1846, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 34) Thread[id=1882, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 35) Thread[id=1835, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 36) Thread[id=1748, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 37) Thread[id=1880, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 38) Thread[id=1832, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 39) Thread[id=1856, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 40) Thread[id=1847, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 41) Thread[id=1850, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 42) Thread[id=1860, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 43) Thread[id=1841, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 44) Thread[id=1795, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 45) Thread[id=1709, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 46) Thread[id=1732, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 47) Thread[id=1761, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 48) Thread[id=1867, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 49) Thread[id=1777, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 50) Thread[id=1719, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 51) Thread[id=1752, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 52) Thread[id=1770, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 53) Thread[id=1831, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 54) Thread[id=1725, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 55) Thread[id=1821, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 56) Thread[id=1807, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 57) Thread[id=1750, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 58) Thread[id=1746, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 59) Thread[id=1755, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 60) Thread[id=1739, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 61) Thread[id=1740, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 62) Thread[id=1849, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 63) Thread[id=1811, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 64) Thread[id=1889, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 65) Thread[id=1819, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 66) Thread[id=1763, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 67) Thread[id=1745, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 68) Thread[id=1783, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 69) Thread[id=1874, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 70) Thread[id=1870, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 71) Thread[id=1753, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 72) Thread[id=1894, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 73) Thread[id=1892, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 74) Thread[id=1724, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 75) Thread[id=1869, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 76) Thread[id=1766, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 77) Thread[id=1708, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 78) Thread[id=1805, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 79) Thread[id=1294, name=SessionTracker, state=TIMED_WAITING, group=TGRP-OverseerTest] at java.lang.Object.wait(Native Method) at java.lang.Object.wait(Object.java:196) at org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:146) 80) Thread[id=1861, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 81) Thread[id=1712, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 82) Thread[id=1758, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 83) Thread[id=1786, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 84) Thread[id=1848, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 85) Thread[id=1873, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 86) Thread[id=1814, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 87) Thread[id=1797, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 88) Thread[id=1706, name=TEST-OverseerTest.testDoubleAssignment-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 89) Thread[id=1812, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 90) Thread[id=1794, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 91) Thread[id=1810, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 92) Thread[id=1862, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 93) Thread[id=1728, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 94) Thread[id=1751, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 95) Thread[id=1789, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 96) Thread[id=1803, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 97) Thread[id=1727, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 98) Thread[id=1834, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 99) Thread[id=1863, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 100) Thread[id=1775, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 101) Thread[id=1714, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 102) Thread[id=1778, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 103) Thread[id=1757, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 104) Thread[id=1866, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 105) Thread[id=1868, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 106) Thread[id=1887, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 107) Thread[id=1799, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 108) Thread[id=1715, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 109) Thread[id=1705, name=TEST-OverseerTest.testDoubleAssignment-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:42391), state=TIMED_WAITING, group=TGRP-OverseerTest] at java.lang.Thread.sleep(Native Method) at java.lang.Thread.sleep(Thread.java:904) at org.apache.zookeeper.client.StaticHostProvider.next(StaticHostProvider.java:86) at org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:937) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:993) 110) Thread[id=1802, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 111) Thread[id=1793, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 112) Thread[id=1829, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 113) Thread[id=1767, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 114) Thread[id=1756, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 115) Thread[id=1858, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 116) Thread[id=1785, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 117) Thread[id=1827, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 118) Thread[id=1878, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 119) Thread[id=1760, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 120) Thread[id=1884, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 121) Thread[id=1886, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 122) Thread[id=1718, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 123) Thread[id=1808, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 124) Thread[id=1792, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 125) Thread[id=1784, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 126) Thread[id=1838, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 127) Thread[id=1859, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 128) Thread[id=1741, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 129) Thread[id=1768, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 130) Thread[id=1833, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 131) Thread[id=1704, name=TEST-OverseerTest.testDoubleAssignment-seed#[96916576CEB213AA]-EventThread, state=TIMED_WAITING, group=TGRP-OverseerTest] at java.lang.Object.wait(Native Method) at java.lang.Object.wait(Object.java:196) at org.apache.solr.common.cloud.ConnectionManager.waitForConnected(ConnectionManager.java:165) at org.apache.solr.common.cloud.ConnectionManager$1.update(ConnectionManager.java:98) at org.apache.solr.common.cloud.DefaultConnectionStrategy.reconnect(DefaultConnectionStrategy.java:46) at org.apache.solr.common.cloud.ConnectionManager.process(ConnectionManager.java:91) at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:519) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:495) 132) Thread[id=1806, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 133) Thread[id=1864, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 134) Thread[id=1729, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 135) Thread[id=1840, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 136) Thread[id=1881, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 137) Thread[id=1828, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 138) Thread[id=1888, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-EventThread, state=WAITING, group=TGRP-OverseerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:197) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2054) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:453) at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:491) 139) Thread[id=1743, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest] at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method) at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240) at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068) 140) Thread[id=1292, name=Thread-362, state=WAITING, group=TGRP-OverseerTest] at java.lang.Object.wait(Native Method) at java.lang.Object.wait(O
[...truncated too long message...]
D_WAITING, group=TGRP-OverseerTest]
[junit4] > at java.lang.Thread.sleep(Native Method)
[junit4] > at java.lang.Thread.sleep(Thread.java:904)
[junit4] > at org.apache.zookeeper.client.StaticHostProvider.next(StaticHostProvider.java:86)
[junit4] > at org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:937)
[junit4] > at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:993)
[junit4] > 87) Thread[id=1781, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest]
[junit4] > at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
[junit4] > at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:240)
[junit4] > at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93)
[junit4] > at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:99)
[junit4] > at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:110)
[junit4] > at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:338)
[junit4] > at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068)
[junit4] > 88) Thread[id=1891, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest]
[junit4] > at java.security.Permissions.implies(Permissions.java:190)
[junit4] > at sun.security.provider.PolicyFile.implies(PolicyFile.java:1144)
[junit4] > at java.security.ProtectionDomain.implies(ProtectionDomain.java:283)
[junit4] > at java.security.AccessController.checkPermission(AccessController.java:118)
[junit4] > at java.lang.SecurityManager.checkPermission(SecurityManager.java:560)
[junit4] > at javax.security.auth.login.Configuration.getConfiguration(Configuration.java:237)
[junit4] > at org.apache.zookeeper.client.ZooKeeperSaslClient.clientTunneledAuthenticationInProgress(ZooKeeperSaslClient.java:487)
[junit4] > at org.apache.zookeeper.ClientCnxn$SendThread.clientTunneledAuthenticationInProgress(ClientCnxn.java:1241)
[junit4] > at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:360)
[junit4] > at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068)
[junit4] > 89) Thread[id=1831, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=TIMED_WAITING, group=TGRP-OverseerTest]
[junit4] > at java.lang.Thread.sleep(Native Method)
[junit4] > at java.lang.Thread.sleep(Thread.java:904)
[junit4] > at org.apache.zookeeper.client.StaticHostProvider.next(StaticHostProvider.java:86)
[junit4] > at org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:937)
[junit4] > at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:993)
[junit4] > 90) Thread[id=1757, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest]
[junit4] > at java.security.Permissions.implies(Permissions.java:191)
[junit4] > at sun.security.provider.PolicyFile.implies(PolicyFile.java:1144)
[junit4] > at java.security.ProtectionDomain.implies(ProtectionDomain.java:283)
[junit4] > at java.security.AccessController.checkPermission(AccessController.java:118)
[junit4] > at java.lang.SecurityManager.checkPermission(SecurityManager.java:560)
[junit4] > at java.lang.SecurityManager.checkPropertyAccess(SecurityManager.java:1313)
[junit4] > at java.lang.System.getProperty(System.java:426)
[junit4] > at java.lang.System.getProperty(System.java:410)
[junit4] > at org.apache.zookeeper.client.ZooKeeperSaslClient.clientTunneledAuthenticationInProgress(ZooKeeperSaslClient.java:487)
[junit4] > at org.apache.zookeeper.ClientCnxn$SendThread.clientTunneledAuthenticationInProgress(ClientCnxn.java:1241)
[junit4] > at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:360)
[junit4] > at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068)
[junit4] > 91) Thread[id=1721, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=TIMED_WAITING, group=TGRP-OverseerTest]
[junit4] > at java.lang.Thread.sleep(Native Method)
[junit4] > at java.lang.Thread.sleep(Thread.java:904)
[junit4] > at org.apache.zookeeper.client.StaticHostProvider.next(StaticHostProvider.java:86)
[junit4] > at org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:937)
[junit4] > at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:993)
[junit4] > 92) Thread[id=1813, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=RUNNABLE, group=TGRP-OverseerTest]
[junit4] > at java.security.AccessController.getProtectionDomains(Native Method)
[junit4] > at java.security.AccessController.checkPermission(AccessController.java:88)
[junit4] > at java.lang.SecurityManager.checkPermission(SecurityManager.java:560)
[junit4] > at javax.security.auth.login.Configuration.getConfiguration(Configuration.java:237)
[junit4] > at org.apache.zookeeper.client.ZooKeeperSaslClient.clientTunneledAuthenticationInProgress(ZooKeeperSaslClient.java:487)
[junit4] > at org.apache.zookeeper.ClientCnxn$SendThread.clientTunneledAuthenticationInProgress(ClientCnxn.java:1241)
[junit4] > at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:360)
[junit4] > at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068)
[junit4] > 93) Thread[id=1725, name=TEST-OverseerTest.testShardAssignmentBigger-seed#[96916576CEB213AA]-SendThread(localhost.localdomain:45176), state=TIMED_WAITING, group=TGRP-OverseerTest]
[junit4] > at java.lang.Thread.sleep(Native Method)
[junit4] > at java.lang.Thread.sleep(Thread.java:904)
[junit4] > at org.apache.zookeeper.client.StaticHostProvider.next(StaticHostProvider.java:86)
[junit4] > at org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:937)
[junit4] > at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:993)
[junit4] > at __randomizedtesting.SeedInfo.seed([96916576CEB213AA]:0)
[junit4] Completed on J0 in 273.15s, 8 tests, 2 failures, 3 errors <<< FAILURES!
[...truncated 409 lines...]
[junit4] Suite: org.apache.solr.logging.TestLogWatcher
[junit4] 2> 845827 T1 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 845904 T1293 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x14099618bf300f0, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:220)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:780)
[junit4] 2>
[junit4] 2> 845906 T1293 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x14099618bf300e8, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:220)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:780)
[junit4] 2>
[junit4] FAILURE 0.17s J0 | TestLogWatcher.testLog4jWatcher <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<1376963129845> but was:<-1>
[junit4] > at org.apache.solr.logging.TestLogWatcher.testLog4jWatcher(TestLogWatcher.java:47)
[junit4] Completed on J0 in 0.17s, 1 test, 1 failure <<< FAILURES!
[...truncated 70 lines...]
BUILD FAILED
/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:389: The following error occurred while executing this line:
/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:382: The following error occurred while executing this line:
/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:39: The following error occurred while executing this line:
/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:181: The following error occurred while executing this line:
/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:450: The following error occurred while executing this line:
/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1230: The following error occurred while executing this line:
/var/lib/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:873: There were test failures: 322 suites, 1372 tests, 3 suite-level errors, 1 error, 2 failures, 548 ignored (5 assumptions)
Total time: 37 minutes 6 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/ibm-j9-jdk7 -Xjit:exclude={org/apache/lucene/util/fst/FST.pack(IIF)Lorg/apache/lucene/util/fst/FST;}
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure