Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/4442/
Java: 64bit/jdk1.7.0_67 -XX:-UseCompressedOops -XX:+UseSerialGC (asserts: true)
1 tests failed.
REGRESSION: org.apache.solr.cloud.RollingRestartTest.testDistribSearch
Error Message:
There are still nodes recoverying - waited for 330 seconds
Stack Trace:
java.lang.AssertionError: There are still nodes recoverying - waited for 330
seconds
at
__randomizedtesting.SeedInfo.seed([D97278EC125C119A:5894F6F4650371A6]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:178)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:137)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:132)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:828)
at
org.apache.solr.cloud.RollingRestartTest.doTest(RollingRestartTest.java:62)
at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
at sun.reflect.GeneratedMethodAccessor96.invoke(Unknown Source)
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:1618)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
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.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:65)
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:365)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
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
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
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:365)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 11708 lines...]
[junit4] Suite: org.apache.solr.cloud.RollingRestartTest
[junit4] 2> Creating dataDir:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\init-core-data-001
[junit4] 2> 6800610 T17026 oas.SolrTestCaseJ4.buildSSLConfig Randomized
ssl (false) and clientAuth (false)
[junit4] 2> 6800610 T17026
oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system
property: /
[junit4] 2> 6800614 T17026 oas.SolrTestCaseJ4.setUp ###Starting
testDistribSearch
[junit4] 2> 6800615 T17026 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 6800616 T17027 oasc.ZkTestServer$ZKServerMain.runFromConfig
Starting server
[junit4] 2> 6800716 T17026 oasc.ZkTestServer.run start zk server on
port:63642
[junit4] 2> 6800716 T17026
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 6800720 T17026 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 6800727 T17034 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@32d6ddd7
name:ZooKeeperConnection Watcher:127.0.0.1:63642 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 6800727 T17026 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 6800728 T17026 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 6800728 T17026 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 6800733 T17028 oazs.NIOServerCnxn.doIO WARN caught end of
stream exception EndOfStreamException: Unable to read additional data from
client sessionid 0x149cc4d866d0000, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 6800733 T17026
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 6800737 T17026 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 6800739 T17037 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@583bf51e
name:ZooKeeperConnection Watcher:127.0.0.1:63642/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 6800739 T17026 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 6800739 T17026 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 6800739 T17026 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 6800745 T17026 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 6800751 T17026 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 6800756 T17026 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 6800762 T17026 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 6800763 T17026 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 6800771 T17026 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 6800771 T17026 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 6800777 T17026 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 6800777 T17026 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 6800782 T17026 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 6800782 T17026 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 6800786 T17026 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 6800787 T17026 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 6800792 T17026 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 6800793 T17026 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 6800798 T17026 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 6800799 T17026 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 6800804 T17026 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 6800804 T17026 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 6800809 T17026 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 6800810 T17026 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 6800814 T17026 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 6800814 T17026 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 6800818 T17026 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 6800819 T17026 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> 6802576 T17026 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 6802584 T17026 oejs.AbstractConnector.doStart Started
[email protected]:63649
[junit4] 2> 6802584 T17026 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 6802584 T17026 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 6802584 T17026 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-002
[junit4] 2> 6802584 T17026 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-002\'
[junit4] 2> 6802622 T17026 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-002\solr.xml
[junit4] 2> 6802692 T17026 oasc.CoreContainer.<init> New CoreContainer
729794400
[junit4] 2> 6802692 T17026 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-002\]
[junit4] 2> 6802695 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 6802695 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 6802695 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 6802695 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 6802695 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 6802695 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 6802695 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 6802695 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 6802695 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 6802698 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 6802698 T17026 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 6802698 T17026 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 6802698 T17026 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 6802698 T17026 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 6802700 T17026 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:63642/solr
[junit4] 2> 6802700 T17026 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 6802700 T17026
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 6802702 T17026 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 6802705 T17049 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@452df924
name:ZooKeeperConnection Watcher:127.0.0.1:63642 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 6802707 T17026 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 6802707 T17026 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 6802709 T17028 oazs.NIOServerCnxn.doIO WARN caught end of
stream exception EndOfStreamException: Unable to read additional data from
client sessionid 0x149cc4d866d0002, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 6802713 T17026 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 6802717 T17052 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@3439276f
name:ZooKeeperConnection Watcher:127.0.0.1:63642/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 6802717 T17026 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 6802719 T17026 oascc.SolrZkClient.makePath makePath:
/overseer/queue
[junit4] 2> 6802724 T17026 oascc.SolrZkClient.makePath makePath:
/overseer/collection-queue-work
[junit4] 2> 6802729 T17026 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-running
[junit4] 2> 6802734 T17026 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-completed
[junit4] 2> 6802739 T17026 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-failure
[junit4] 2> 6802745 T17026 oascc.SolrZkClient.makePath makePath:
/live_nodes
[junit4] 2> 6802747 T17026 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63649_
[junit4] 2> 6802749 T17026 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:63649_
[junit4] 2> 6802753 T17026 oascc.SolrZkClient.makePath makePath:
/overseer_elect
[junit4] 2> 6802755 T17026 oascc.SolrZkClient.makePath makePath:
/overseer_elect/election
[junit4] 2> 6802759 T17026 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 6802762 T17026 oasc.OverseerElectionContext.runLeaderProcess I
am going to be the leader 127.0.0.1:63649_
[junit4] 2> 6802762 T17026 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 6802765 T17026 oasc.Overseer.start Overseer
(id=92829900677644291-127.0.0.1:63649_-n_0000000000) starting
[junit4] 2> 6802770 T17026 oascc.SolrZkClient.makePath makePath:
/overseer/queue-work
[junit4] 2> 6802789 T17026 oasc.OverseerAutoReplicaFailoverThread.<init>
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 6802792 T17054 oasc.OverseerCollectionProcessor.run Process
current queue of collection creations
[junit4] 2> 6802792 T17026 oascc.SolrZkClient.makePath makePath:
/clusterstate.json
[junit4] 2> 6802798 T17026 oascc.SolrZkClient.makePath makePath:
/aliases.json
[junit4] 2> 6802801 T17026
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 6802812 T17053 oasc.Overseer$ClusterStateUpdater.run Starting
to work on the main queue
[junit4] 2> 6802821 T17056 oasc.ZkController.publish publishing
core=collection1 state=down collection=control_collection
[junit4] 2> 6802821 T17056 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 6802823 T17052 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 6802823 T17056 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 6802829 T17053 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=1 message={
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:63649_",
[junit4] 2> "numShards":"1",
[junit4] 2> "base_url":"http://127.0.0.1:63649";,
[junit4] 2> "operation":"state",
[junit4] 2> "shard":null,
[junit4] 2> "roles":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "core":"collection1"}
[junit4] 2> 6802829 T17053
oasc.Overseer$ClusterStateUpdater.createCollection Create collection
control_collection with shards [shard1]
[junit4] 2> 6802830 T17053
oasc.Overseer$ClusterStateUpdater.createCollection state version
control_collection 1
[junit4] 2> 6802830 T17053 oasc.Overseer$ClusterStateUpdater.updateState
Assigning new node to shard shard=shard1
[junit4] 2> 6802834 T17052 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> 6803814 T17056 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for collection1
[junit4] 2> 6803814 T17056 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:control_collection
[junit4] 2> 6803817 T17056 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 6803817 T17056 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/control_collection
[junit4] 2> 6803820 T17056 oascc.ZkStateReader.readConfigName
path=/collections/control_collection configName=conf1 specified config exists
in ZooKeeper
[junit4] 2> 6803820 T17056 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-002\collection1\'
[junit4] 2> 6803825 T17056 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest-D97278EC125C119A-001/tempDir-002/collection1/lib/.svn/'
to classloader
[junit4] 2> 6803827 T17056 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest-D97278EC125C119A-001/tempDir-002/collection1/lib/classes/'
to classloader
[junit4] 2> 6803827 T17056 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest-D97278EC125C119A-001/tempDir-002/collection1/lib/README'
to classloader
[junit4] 2> 6803909 T17056 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 6.0.0
[junit4] 2> 6803962 T17056 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 6803965 T17056 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 6803981 T17056 oass.IndexSchema.readSchema [collection1]
Schema name=test
[junit4] 2> 6804506 T17056 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 6804515 T17056 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 6804519 T17056 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 6804539 T17056 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 6804546 T17056 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 6804552 T17056 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 6804554 T17056
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 6804557 T17056
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 6804557 T17056 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 6804559 T17056
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 6804560 T17056
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 6804561 T17056 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection control_collection
[junit4] 2> 6804561 T17056 oasc.SolrCore.initDirectoryFactory
solr.StandardDirectoryFactory
[junit4] 2> 6804561 T17056 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-002\collection1\,
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001/control/data\
[junit4] 2> 6804562 T17056 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1c69143c
[junit4] 2> 6804566 T17056 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\control\data
[junit4] 2> 6804567 T17056 oasc.SolrCore.getNewIndexDir New index
directory detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001/control/data\index/
[junit4] 2> 6804568 T17056 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\control\data\index'
doesn't exist. Creating new index...
[junit4] 2> 6804571 T17056 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\control\data\index
[junit4] 2> 6804571 T17056 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=31, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=9.55859375,
floorSegmentMB=2.1923828125, forceMergeDeletesPctAllowed=18.203530444533442,
segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6251355237556602
[junit4] 2> 6804571 T17056 oasc.CachingDirectoryFactory.closeCacheValue
looking to close
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\control\data\index
[CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\control\data\index;done=true>>]
[junit4] 2> 6804571 T17056 oasc.CachingDirectoryFactory.close Closing
directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\control\data\index
[junit4] 2> 6804571 T17056 oasc.SolrCore.close [collection1] CLOSING
SolrCore org.apache.solr.core.SolrCore@9b5b8b5
[junit4] 2> 6804571 T17056 oasu.SolrCoreState.decrefSolrCoreState Closing
SolrCoreState
[junit4] 2> 6804572 T17056 oasu.DefaultSolrCoreState.closeIndexWriter
SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 6804572 T17056 oasc.SolrCore.closeSearcher [collection1]
Closing main searcher on request.
[junit4] 2> 6804573 T17056 oasc.CachingDirectoryFactory.close Closing
StandardDirectoryFactory - 1 directories currently being tracked
[junit4] 2> 6804573 T17056 oasc.CachingDirectoryFactory.closeCacheValue
looking to close
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\control\data
[CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\control\data;done=false>>]
[junit4] 2> 6804574 T17056 oasc.CachingDirectoryFactory.close Closing
directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\control\data
[junit4] 2> 6804574 T17056 oasc.CoreContainer.create ERROR Error creating
core [collection1]: Error instantiating class:
'org.apache.lucene.util.LuceneTestCase$3' org.apache.solr.common.SolrException:
Error instantiating class: 'org.apache.lucene.util.LuceneTestCase$3'
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:895)
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:653)
[junit4] 2> at
org.apache.solr.core.CoreContainer.create(CoreContainer.java:510)
[junit4] 2> at
org.apache.solr.core.CoreContainer$1.call(CoreContainer.java:274)
[junit4] 2> at
org.apache.solr.core.CoreContainer$1.call(CoreContainer.java:268)
[junit4] 2> at
java.util.concurrent.FutureTask.run(FutureTask.java:262)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> Caused by: org.apache.solr.common.SolrException: Error
instantiating class: 'org.apache.lucene.util.LuceneTestCase$3'
[junit4] 2> at
org.apache.solr.core.SolrResourceLoader.newInstance(SolrResourceLoader.java:534)
[junit4] 2> at
org.apache.solr.core.SolrResourceLoader.newInstance(SolrResourceLoader.java:519)
[junit4] 2> at
org.apache.solr.update.SolrIndexConfig.buildMergeScheduler(SolrIndexConfig.java:305)
[junit4] 2> at
org.apache.solr.update.SolrIndexConfig.toIndexWriterConfig(SolrIndexConfig.java:230)
[junit4] 2> at
org.apache.solr.update.SolrIndexWriter.<init>(SolrIndexWriter.java:77)
[junit4] 2> at
org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:64)
[junit4] 2> at
org.apache.solr.core.SolrCore.initIndex(SolrCore.java:530)
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:797)
[junit4] 2> ... 8 more
[junit4] 2> Caused by: java.lang.IllegalAccessException: Class
org.apache.solr.core.SolrResourceLoader can not access a member of class
org.apache.lucene.util.LuceneTestCase$3 with modifiers ""
[junit4] 2> at
sun.reflect.Reflection.ensureMemberAccess(Reflection.java:109)
[junit4] 2> at java.lang.Class.newInstance(Class.java:368)
[junit4] 2> at
org.apache.solr.core.SolrResourceLoader.newInstance(SolrResourceLoader.java:531)
[junit4] 2> ... 15 more
[junit4] 2>
[junit4] 2> 6804577 T17026 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 6804577 T17026 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 6804579 T17026
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 6804581 T17026 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 6804585 T17060 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@dbf9afd name:ZooKeeperConnection
Watcher:127.0.0.1:63642/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 6804585 T17026 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 6804586 T17026 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 6804589 T17026
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 6804596 T17026 oasc.ChaosMonkey.monkeyLog monkey: init -
expire sessions:false cause connection loss:false
[junit4] 2> 6806380 T17026 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1
[junit4] 2> 6806382 T17026 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 6806386 T17026 oejs.AbstractConnector.doStart Started
[email protected]:63661
[junit4] 2> 6806387 T17026 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 6806387 T17026 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 6806387 T17026 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-003
[junit4] 2> 6806387 T17026 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-003\'
[junit4] 2> 6806432 T17026 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-003\solr.xml
[junit4] 2> 6806498 T17026 oasc.CoreContainer.<init> New CoreContainer
1029015328
[junit4] 2> 6806498 T17026 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-003\]
[junit4] 2> 6806500 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 6806500 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 6806500 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 6806500 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 6806500 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 6806503 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 6806503 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 6806503 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 6806503 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 6806503 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 6806503 T17026 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 6806503 T17026 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 6806503 T17026 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 6806503 T17026 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 6806503 T17026 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:63642/solr
[junit4] 2> 6806506 T17026 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 6806506 T17026
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 6806511 T17026 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 6806514 T17072 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@748cc8c name:ZooKeeperConnection
Watcher:127.0.0.1:63642 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 6806515 T17026 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 6806516 T17026 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 6806521 T17026 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 6806523 T17075 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@671b49e6
name:ZooKeeperConnection Watcher:127.0.0.1:63642/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 6806524 T17026 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 6806544 T17026
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 6807540 T17026 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63661_
[junit4] 2> 6807542 T17026 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:63661_
[junit4] 2> 6807562 T17026 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 6807573 T17076 oasc.ZkController.publish publishing
core=collection1 state=down collection=collection1
[junit4] 2> 6807573 T17076 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 6807575 T17076 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 6807575 T17052 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 6807582 T17053 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:63661_",
[junit4] 2> "numShards":"2",
[junit4] 2> "base_url":"http://127.0.0.1:63661";,
[junit4] 2> "operation":"state",
[junit4] 2> "shard":null,
[junit4] 2> "roles":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "core":"collection1"}
[junit4] 2> 6807582 T17053
oasc.Overseer$ClusterStateUpdater.createCollection Create collection
collection1 with shards [shard1, shard2]
[junit4] 2> 6807583 T17053
oasc.Overseer$ClusterStateUpdater.createCollection state version collection1 1
[junit4] 2> 6807583 T17053 oasc.Overseer$ClusterStateUpdater.updateState
Assigning new node to shard shard=shard1
[junit4] 2> 6807589 T17060 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> 6807590 T17052 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> 6807589 T17075 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> 6808565 T17076 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for collection1
[junit4] 2> 6808565 T17076 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:collection1
[junit4] 2> 6808566 T17076 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 6808566 T17076 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 6808569 T17076 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 6808569 T17076 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-003\collection1\'
[junit4] 2> 6808572 T17076 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest-D97278EC125C119A-001/tempDir-003/collection1/lib/.svn/'
to classloader
[junit4] 2> 6808574 T17076 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest-D97278EC125C119A-001/tempDir-003/collection1/lib/classes/'
to classloader
[junit4] 2> 6808576 T17076 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest-D97278EC125C119A-001/tempDir-003/collection1/lib/README'
to classloader
[junit4] 2> 6808680 T17076 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 6.0.0
[junit4] 2> 6808744 T17076 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 6808747 T17076 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 6808764 T17076 oass.IndexSchema.readSchema [collection1]
Schema name=test
[junit4] 2> 6809209 T17076 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 6809225 T17076 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 6809228 T17076 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 6809253 T17076 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 6809258 T17076 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 6809263 T17076 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 6809265 T17076
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 6809266 T17076
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 6809266 T17076 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 6809268 T17076
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 6809268 T17076
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 6809268 T17076 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection collection1
[junit4] 2> 6809268 T17076 oasc.SolrCore.initDirectoryFactory
solr.StandardDirectoryFactory
[junit4] 2> 6809268 T17076 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-003\collection1\,
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001/jetty1\
[junit4] 2> 6809268 T17076 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1c69143c
[junit4] 2> 6809271 T17076 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\jetty1
[junit4] 2> 6809272 T17076 oasc.SolrCore.getNewIndexDir New index
directory detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001/jetty1\index/
[junit4] 2> 6809272 T17076 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\jetty1\index'
doesn't exist. Creating new index...
[junit4] 2> 6809274 T17076 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\jetty1\index
[junit4] 2> 6809274 T17076 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=31, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=9.55859375,
floorSegmentMB=2.1923828125, forceMergeDeletesPctAllowed=18.203530444533442,
segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6251355237556602
[junit4] 2> 6809275 T17076 oasc.CachingDirectoryFactory.closeCacheValue
looking to close
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\jetty1\index
[CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\jetty1\index;done=true>>]
[junit4] 2> 6809275 T17076 oasc.CachingDirectoryFactory.close Closing
directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\jetty1\index
[junit4] 2> 6809275 T17076 oasc.SolrCore.close [collection1] CLOSING
SolrCore org.apache.solr.core.SolrCore@bd37f4d
[junit4] 2> 6809275 T17076 oasu.SolrCoreState.decrefSolrCoreState Closing
SolrCoreState
[junit4] 2> 6809275 T17076 oasu.DefaultSolrCoreState.closeIndexWriter
SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 6809275 T17076 oasc.SolrCore.closeSearcher [collection1]
Closing main searcher on request.
[junit4] 2> 6809276 T17076 oasc.CachingDirectoryFactory.close Closing
StandardDirectoryFactory - 1 directories currently being tracked
[junit4] 2> 6809276 T17076 oasc.CachingDirectoryFactory.closeCacheValue
looking to close
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\jetty1
[CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\jetty1;done=false>>]
[junit4] 2> 6809277 T17076 oasc.CachingDirectoryFactory.close Closing
directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\jetty1
[junit4] 2> 6809277 T17076 oasc.CoreContainer.create ERROR Error creating
core [collection1]: Error instantiating class:
'org.apache.lucene.util.LuceneTestCase$3' org.apache.solr.common.SolrException:
Error instantiating class: 'org.apache.lucene.util.LuceneTestCase$3'
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:895)
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:653)
[junit4] 2> at
org.apache.solr.core.CoreContainer.create(CoreContainer.java:510)
[junit4] 2> at
org.apache.solr.core.CoreContainer$1.call(CoreContainer.java:274)
[junit4] 2> at
org.apache.solr.core.CoreContainer$1.call(CoreContainer.java:268)
[junit4] 2> at
java.util.concurrent.FutureTask.run(FutureTask.java:262)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> Caused by: org.apache.solr.common.SolrException: Error
instantiating class: 'org.apache.lucene.util.LuceneTestCase$3'
[junit4] 2> at
org.apache.solr.core.SolrResourceLoader.newInstance(SolrResourceLoader.java:534)
[junit4] 2> at
org.apache.solr.core.SolrResourceLoader.newInstance(SolrResourceLoader.java:519)
[junit4] 2> at
org.apache.solr.update.SolrIndexConfig.buildMergeScheduler(SolrIndexConfig.java:305)
[junit4] 2> at
org.apache.solr.update.SolrIndexConfig.toIndexWriterConfig(SolrIndexConfig.java:230)
[junit4] 2> at
org.apache.solr.update.SolrIndexWriter.<init>(SolrIndexWriter.java:77)
[junit4] 2> at
org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:64)
[junit4] 2> at
org.apache.solr.core.SolrCore.initIndex(SolrCore.java:530)
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:797)
[junit4] 2> ... 8 more
[junit4] 2> Caused by: java.lang.IllegalAccessException: Class
org.apache.solr.core.SolrResourceLoader can not access a member of class
org.apache.lucene.util.LuceneTestCase$3 with modifiers ""
[junit4] 2> at
sun.reflect.Reflection.ensureMemberAccess(Reflection.java:109)
[junit4] 2> at java.lang.Class.newInstance(Class.java:368)
[junit4] 2> at
org.apache.solr.core.SolrResourceLoader.newInstance(SolrResourceLoader.java:531)
[junit4] 2> ... 15 more
[junit4] 2>
[junit4] 2> 6809279 T17026 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 6809279 T17026 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 6810735 T17026 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2
[junit4] 2> 6810736 T17026 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 6810741 T17026 oejs.AbstractConnector.doStart Started
[email protected]:63670
[junit4] 2> 6810742 T17026 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 6810742 T17026 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 6810742 T17026 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-004
[junit4] 2> 6810742 T17026 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-004\'
[junit4] 2> 6810775 T17026 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-004\solr.xml
[junit4] 2> 6810838 T17026 oasc.CoreContainer.<init> New CoreContainer
1228527370
[junit4] 2> 6810838 T17026 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-004\]
[junit4] 2> 6810841 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 6810841 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 6810841 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 6810841 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 6810842 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 6810842 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 6810842 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 6810842 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 6810842 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 6810842 T17026 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 6810842 T17026 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 6810842 T17026 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 6810843 T17026 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 6810844 T17026 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 6810844 T17026 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:63642/solr
[junit4] 2> 6810844 T17026 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 6810845 T17026
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 6810847 T17026 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 6810849 T17089 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@52f6af7e
name:ZooKeeperConnection Watcher:127.0.0.1:63642 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 6810850 T17026 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 6810851 T17026 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 6810853 T17028 oazs.NIOServerCnxn.doIO WARN caught end of
stream exception EndOfStreamException: Unable to read additional data from
client sessionid 0x149cc4d866d0007, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 6810856 T17026 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 6810859 T17092 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@49edfb60
name:ZooKeeperConnection Watcher:127.0.0.1:63642/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 6810860 T17026 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 6810877 T17026
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 6811778 T17026 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63670_
[junit4] 2> 6811779 T17026 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:63670_
[junit4] 2> 6811787 T17026 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 6811797 T17093 oasc.ZkController.publish publishing
core=collection1 state=down collection=collection1
[junit4] 2> 6811797 T17093 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 6811799 T17093 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 6811799 T17052 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 6811804 T17053 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:63670_",
[junit4] 2> "numShards":"2",
[junit4] 2> "base_url":"http://127.0.0.1:63670";,
[junit4] 2> "operation":"state",
[junit4] 2> "shard":null,
[junit4] 2> "roles":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "core":"collection1"}
[junit4] 2> 6811805 T17053 oasc.Overseer$ClusterStateUpdater.updateState
Collection already exists with numShards=2
[junit4] 2> 6811805 T17053 oasc.Overseer$ClusterStateUpdater.updateState
Assigning new node to shard shard=shard2
[junit4] 2> 6811810 T17092 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> 6811810 T17052 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> 6811810 T17060 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> 6811810 T17075 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> 6812691 T17093 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for collection1
[junit4] 2> 6812691 T17093 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:collection1
[junit4] 2> 6812693 T17093 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 6812693 T17093 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 6812697 T17093 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 6812697 T17093 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-004\collection1\'
[junit4] 2> 6812700 T17093 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest-D97278EC125C119A-001/tempDir-004/collection1/lib/.svn/'
to classloader
[junit4] 2> 6812703 T17093 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest-D97278EC125C119A-001/tempDir-004/collection1/lib/classes/'
to classloader
[junit4] 2> 6812704 T17093 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest-D97278EC125C119A-001/tempDir-004/collection1/lib/README'
to classloader
[junit4] 2> 6812772 T17093 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 6.0.0
[junit4] 2> 6812825 T17093 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 6812826 T17093 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 6812835 T17093 oass.IndexSchema.readSchema [collection1]
Schema name=test
[junit4] 2> 6813306 T17093 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 6813313 T17093 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 6813315 T17093 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 6813341 T17093 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 6813351 T17093 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 6813359 T17093 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 6813361 T17093
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 6813363 T17093
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 6813364 T17093 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 6813366 T17093
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 6813366 T17093
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 6813366 T17093 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection collection1
[junit4] 2> 6813367 T17093 oasc.SolrCore.initDirectoryFactory
solr.StandardDirectoryFactory
[junit4] 2> 6813367 T17093 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-004\collection1\,
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001/jetty2\
[junit4] 2> 6813367 T17093 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1c69143c
[junit4] 2> 6813368 T17093 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\jetty2
[junit4] 2> 6813369 T17093 oasc.SolrCore.getNewIndexDir New index
directory detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001/jetty2\index/
[junit4] 2> 6813370 T17093 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\jetty2\index'
doesn't exist. Creating new index...
[junit4] 2> 6813371 T17093 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\jetty2\index
[junit4] 2> 6813372 T17093 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=31, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=9.55859375,
floorSegmentMB=2.1923828125, forceMergeDeletesPctAllowed=18.203530444533442,
segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6251355237556602
[junit4] 2> 6813372 T17093 oasc.CachingDirectoryFactory.closeCacheValue
looking to close
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\jetty2\index
[CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\jetty2\index;done=true>>]
[junit4] 2> 6813373 T17093 oasc.CachingDirectoryFactory.close Closing
directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\jetty2\index
[junit4] 2> 6813373 T17093 oasc.SolrCore.close [collection1] CLOSING
SolrCore org.apache.solr.core.SolrCore@249720e7
[junit4] 2> 6813373 T17093 oasu.SolrCoreState.decrefSolrCoreState Closing
SolrCoreState
[junit4] 2> 6813373 T17093 oasu.DefaultSolrCoreState.closeIndexWriter
SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 6813374 T17093 oasc.SolrCore.closeSearcher [collection1]
Closing main searcher on request.
[junit4] 2> 6813374 T17093 oasc.CachingDirectoryFactory.close Closing
StandardDirectoryFactory - 1 directories currently being tracked
[junit4] 2> 6813374 T17093 oasc.CachingDirectoryFactory.closeCacheValue
looking to close
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\jetty2
[CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\jetty2;done=false>>]
[junit4] 2> 6813375 T17093 oasc.CachingDirectoryFactory.close Closing
directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.RollingRestartTest-D97278EC125C119A-001\tempDir-001\jetty2
[junit4] 2> 6813375 T17093 oasc.CoreContainer.create ERROR Error creating
core [collection1]: Error instantiating class:
'org.apache.lucene.util.LuceneTestCase$3' org.apache.solr.common.SolrException:
Error instantiating class: 'org.apache.lucene.util.LuceneTestCase$3'
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:895)
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:653)
[junit4] 2> at
org.apache.solr.core.CoreContainer.create(CoreContainer.java:510)
[junit4] 2> at
org.apache.solr.core.CoreContainer$1.call(CoreContainer.java:274)
[junit4] 2> at
org.apache.solr.core.CoreContainer$1.call(CoreContainer.java:268)
[junit4] 2> at
java.util.concurrent.FutureTask.run(FutureTask.java:262)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> Caused by: org.apache.solr.common.SolrException: Error
instantiating class: 'org.apache.lucene.util.LuceneTestCase$3'
[junit4] 2> at
org.apache.solr.core.SolrResourceLoader.newInstance(SolrResourceLoader.java:534)
[junit4] 2> at
org.apache.solr.core.SolrResourceLoader.newInstance(SolrResourceLoader.java:519)
[junit4] 2> at
org.apache.solr.update.SolrIndexConfig.buildMergeScheduler(SolrIndexConfig.java:305)
[junit4] 2> at
org.apache.solr.update.SolrIndexConfig.toIndexWriterConfig(SolrIndexConfig.java:230)
[junit4] 2> at
org.apache.solr.update.SolrIndexWriter.<init>(SolrIndexWriter.java:77)
[junit4] 2> at
org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:64)
[junit4] 2> at
org.apache.solr.core.SolrCore.initIndex(SolrCore.java:530)
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:797)
[junit4] 2> ... 8 more
[junit4] 2> Caused by: java.lang.IllegalAccessException: Class
org.apache.solr.core.SolrResourceLoader can not access a member of class
org.apache.lucene.util.LuceneTestCase$3 with modifiers ""
[junit4] 2> at
sun.reflect.Reflection.ensureMemberAccess(Reflection.java:109)
[junit4] 2> at java.lang.Class.newInstance(Class.java:368)
[junit4] 2> at
org.apache.solr.core.SolrResourceLoader.newInstance(SolrResourceLoader.java:531)
[junit4] 2> ... 15 more
[junit4] 2>
[junit4] 2> 6813378 T17026 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 6813378 T17026 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 6813383 T17026
oasc.AbstractDistribZkTestBase.waitForRecoveriesToFinish Wait for recoveries to
finish - collection: collection1 failOnTimeout:true timeout (sec):330
[junit4] 2> 7154302 T17026 oasc.Diagnostics.logThreadDumps ERROR Gave up
waiting for recovery to finish. THREAD DUMP:
[junit4] 2> "Thread-5681" Id=17094 WAITING on
java.lang.Object@152e63d8
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> - waiting on java.lang.Object@152e63d8
[junit4] 2> at java.lang.Object.wait(Object.java:503)
[junit4] 2> at
org.apache.solr.core.CloserThread.run(CoreContainer.java:925)
[junit4] 2>
[junit4] 2>
"TEST-RollingRestartTest.testDistribSearch-seed#[D97278EC125C119A]-EventThread"
Id=17091 WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@cce21d8
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@cce21d8
[junit4] 2> at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
[junit4] 2> at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:494)
[junit4] 2>
[junit4] 2>
"TEST-RollingRestartTest.testDistribSearch-seed#[D97278EC125C119A]-SendThread(127.0.0.1:63642)"
Id=17090 RUNNABLE (in native)
[junit4] 2> at
sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
[junit4] 2> at
sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:296)
[junit4] 2> at
sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:278)
[junit4] 2> at
sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:159)
[junit4] 2> at
sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
[junit4] 2> - locked sun.nio.ch.Util$2@df7ff19
[junit4] 2> - locked
java.util.Collections$UnmodifiableSet@26ff3179
[junit4] 2> - locked
sun.nio.ch.WindowsSelectorImpl@77ba27b3
[junit4] 2> at
sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:349)
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1081)
[junit4] 2>
[junit4] 2> "qtp685311376-17086" Id=17086 TIMED_WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@5e84962d
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@5e84962d
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082)
[junit4] 2> at
org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> "qtp685311376-17085" Id=17085 TIMED_WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@5e84962d
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@5e84962d
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082)
[junit4] 2> at
org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> "qtp685311376-17084" Id=17084 TIMED_WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@5e84962d
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@5e84962d
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082)
[junit4] 2> at
org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> "qtp685311376-17083" Id=17083 TIMED_WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@5e84962d
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@5e84962d
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082)
[junit4] 2> at
org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> "qtp685311376-17082" Id=17082 TIMED_WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@5e84962d
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@5e84962d
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082)
[junit4] 2> at
org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> "qtp685311376-17081" Id=17081 TIMED_WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@5e84962d
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@5e84962d
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082)
[junit4] 2> at
org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> "qtp685311376-17080 Acceptor0
[email protected]:63670" Id=17080 RUNNABLE (in native)
[junit4] 2> at
sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
[junit4] 2> at
sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:241)
[junit4] 2> - locked java.lang.Object@529f94d5
[junit4] 2> at
org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:109)
[junit4] 2> at
org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:938)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> "qtp685311376-17079 Selector0" Id=17079 RUNNABLE (in
native)
[junit4] 2> at
sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
[junit4] 2> at
sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:296)
[junit4] 2> at
sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:278)
[junit4] 2> at
sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:159)
[junit4] 2> at
sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
[junit4] 2> - locked sun.nio.ch.Util$2@34df99f8
[junit4] 2> - locked
java.util.Collections$UnmodifiableSet@2ba693e5
[junit4] 2> - locked
sun.nio.ch.WindowsSelectorImpl@4c7efdaa
[junit4] 2> at
sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
[junit4] 2> at
org.eclipse.jetty.io.nio.SelectorManager$SelectSet.doSelect(SelectorManager.java:569)
[junit4] 2> at
org.eclipse.jetty.io.nio.SelectorManager$1.run(SelectorManager.java:290)
[junit4] 2> ...
[junit4] 2>
[junit4] 2> "HashSessionScavenger-382" Id=17078 TIMED_WAITING on
java.util.TaskQueue@253fcb22
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> - waiting on java.util.TaskQueue@253fcb22
[junit4] 2> at
java.util.TimerThread.mainLoop(Timer.java:552)
[junit4] 2> at java.util.TimerThread.run(Timer.java:505)
[junit4] 2>
[junit4] 2> "Thread-5671" Id=17077 WAITING on
java.lang.Object@152e63d8
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> - waiting on java.lang.Object@152e63d8
[junit4] 2> at java.lang.Object.wait(Object.java:503)
[junit4] 2> at
org.apache.solr.core.CloserThread.run(CoreContainer.java:925)
[junit4] 2>
[junit4] 2>
"TEST-RollingRestartTest.testDistribSearch-seed#[D97278EC125C119A]-EventThread"
Id=17074 WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@7f313848
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@7f313848
[junit4] 2> at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
[junit4] 2> at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:494)
[junit4] 2>
[junit4] 2>
"TEST-RollingRestartTest.testDistribSearch-seed#[D97278EC125C119A]-SendThread(127.0.0.1:63642)"
Id=17073 RUNNABLE (in native)
[junit4] 2> at
sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
[junit4] 2> at
sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:296)
[junit4] 2> at
sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:278)
[junit4] 2> at
sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:159)
[junit4] 2> at
sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
[junit4] 2> - locked sun.nio.ch.Util$2@10153ad
[junit4] 2> - locked
java.util.Collections$UnmodifiableSet@1f4d101
[junit4] 2> - locked
sun.nio.ch.WindowsSelectorImpl@15eadc45
[junit4] 2> at
sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:349)
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1081)
[junit4] 2>
[junit4] 2> "qtp702713340-17069" Id=17069 TIMED_WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@6e234140
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@6e234140
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082)
[junit4] 2> at
org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> "qtp702713340-17068" Id=17068 TIMED_WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@6e234140
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@6e234140
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082)
[junit4] 2> at
org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> "qtp702713340-17067" Id=17067 TIMED_WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@6e234140
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@6e234140
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082)
[junit4] 2> at
org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> "qtp702713340-17066" Id=17066 TIMED_WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@6e234140
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@6e234140
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082)
[junit4] 2> at
org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> "qtp702713340-17065" Id=17065 TIMED_WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@6e234140
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@6e234140
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082)
[junit4] 2> at
org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> "qtp702713340-17064" Id=17064 TIMED_WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@6e234140
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@6e234140
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082)
[junit4] 2> at
org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> "qtp702713340-17063 Acceptor0
[email protected]:63661" Id=17063 RUNNABLE (in native)
[junit4] 2> at
sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
[junit4] 2> at
sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:241)
[junit4] 2> - locked java.lang.Object@4c91093d
[junit4] 2> at
org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:109)
[junit4] 2> at
org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:938)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> "qtp702713340-17062 Selector0" Id=17062 RUNNABLE
[junit4] 2> at
sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
[junit4] 2> at
sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:296)
[junit4] 2> at
sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:278)
[junit4] 2> at
sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:159)
[junit4] 2> at
sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
[junit4] 2> - locked sun.nio.ch.Util$2@3b1cb52
[junit4] 2> - locked
java.util.Collections$UnmodifiableSet@5979648f
[junit4] 2> - locked
sun.nio.ch.WindowsSelectorImpl@475efd58
[junit4] 2>
[...truncated too long message...]
1.7.0_67 (64-bit)/cpus=2,threads=1,free=201795384,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestSolrXmlPersistence,
AnalyticsMergeStrategyTest, BadComponentTest, TestFieldResource,
SpatialFilterTest, LeaderElectionTest, SyncSliceTest, HdfsSyncSliceTest,
TestMultiCoreConfBootstrap, HdfsWriteToMultipleCollectionsTest,
StatelessScriptUpdateProcessorFactoryTest, ShardSplitTest, TestRecovery,
TestSolrQueryParser, TriLevelCompositeIdRoutingTest, HighlighterConfigTest,
DistribCursorPagingTest, TestOverriddenPrefixQueryForCustomFieldType,
TestDistributedMissingSort, TestComplexPhraseQParserPlugin,
DirectSolrSpellCheckerTest, AsyncMigrateRouteKeyTest, TestOmitPositions,
HdfsBasicDistributedZk2Test, CSVRequestHandlerTest, ScriptEngineTest,
TestFieldTypeCollectionResource, SortByFunctionTest, ModifyConfFileTest,
SuggesterTSTTest, InfoHandlerTest, AddSchemaFieldsUpdateProcessorFactoryTest,
TestQueryTypes, OpenExchangeRatesOrgProviderTest, PreAnalyzedFieldTest,
TestLuceneMatchVersion, TestReplicationHandler, TestFuzzyAnalyzedSuggestions,
ChangedSchemaMergeTest, TermVectorComponentDistributedTest,
TestFoldingMultitermQuery, PolyFieldTest, IndexSchemaTest, AtomicUpdatesTest,
TestDistributedGrouping, SuggesterWFSTTest, WordBreakSolrSpellCheckerTest,
TestGroupingSearch, DistributedQueueTest, SolrCoreCheckLockOnStartupTest,
ClusterStateTest, DistributedSpellCheckComponentTest, TestRemoteStreaming,
TestCSVLoader, AnalyticsQueryTest, HighlighterTest, CopyFieldTest, TestJoin,
TestTolerantSearch, TestMergePolicyConfig, TestStressRecovery,
TestFastOutputStream, DistributedFacetPivotSmallTest, TestRangeQuery,
DocValuesTest, RequiredFieldsTest, TestSolrXml, TestBinaryField,
StressHdfsTest, AssignTest, TestBulkSchemaConcurrent, DocumentBuilderTest,
MultiThreadedOCPTest, TestAnalyzeInfixSuggestions, TestLazyCores,
TermVectorComponentTest, TestSearcherReuse, TestSystemIdResolver,
BlockDirectoryTest, TestSolrQueryParserDefaultOperatorResource, TestBadConfig,
LeaderInitiatedRecoveryOnCommitTest, NoCacheHeaderTest,
SpellCheckComponentTest, TestCopyFieldCollectionResource, TestDocumentBuilder,
CoreMergeIndexesAdminHandlerTest, TestRestManager, TestBlendedInfixSuggestions,
OverseerTest, TestSolrConfigHandlerConcurrent, TestRandomDVFaceting,
RAMDirectoryFactoryTest, BlockCacheTest, TestManagedResource,
TestSolrDynamicMBean, TestCSVResponseWriter, HttpPartitionTest,
FieldMutatingUpdateProcessorTest, SuggesterTest, TestFreeTextSuggestions,
TestSchemaSimilarityResource, StandardRequestHandlerTest,
ConnectionManagerTest, TestNonNRTOpen, TestSuggestSpellingConverter,
CloudExitableDirectoryReaderTest, SuggestComponentTest, RemoteQueryErrorTest,
TestStandardQParsers, MBeansHandlerTest, SharedFSAutoReplicaFailoverTest,
SimpleFacetsTest, TestRealTimeGet, TestLMDirichletSimilarityFactory,
TestModifyConfFiles, TestChildDocTransformer, TestExpandComponent,
TestRawResponseWriter, ResponseLogComponentTest, DOMUtilTest, TestUpdate,
BasicFunctionalityTest, DeleteReplicaTest, SimpleCollectionCreateDeleteTest,
TestStressLucene, DeleteShardTest, TestShardHandlerFactory,
TestCursorMarkWithoutUniqueKey, BasicDistributedZkTest,
TestIndexingPerformance, DistributedSuggestComponentTest, QueryEqualityTest,
TestStressVersions, ZkSolrClientTest, TestQuerySenderNoQuery, UUIDFieldTest,
TestValueSourceCache, TestSolrXmlPersistor, TestCloudSchemaless,
DistributedDebugComponentTest, TestConfigOverlay, CurrencyFieldXmlFileTest,
DateFieldTest, TestReversedWildcardFilterFactory, HdfsRecoveryZkTest,
TestCloudInspectUtil, DebugComponentTest, SolrIndexConfigTest,
DistributedFacetPivotWhiteBoxTest, LukeRequestHandlerTest,
AnalysisErrorHandlingTest, TestCoreContainer, TestCloudManagedSchemaConcurrent,
TestLFUCache, TestIndexSearcher, ZkCLITest, AnalysisAfterCoreReloadTest,
TestDFRSimilarityFactory, UUIDUpdateProcessorFallbackTest,
TestPseudoReturnFields, PrimUtilsTest, OutputWriterTest, TestArbitraryIndexDir,
TestLRUCache, TestDynamicFieldCollectionResource, ShardRoutingTest,
CoreAdminRequestStatusTest, StatsComponentTest, OverseerRolesTest,
SolrCoreTest, DirectSolrConnectionTest, QueryElevationComponentTest,
ShowFileRequestHandlerTest, DisMaxRequestHandlerTest,
TestDefaultSimilarityFactory, MinimalSchemaTest, SoftAutoCommitTest,
PeerSyncTest, SolrTestCaseJ4Test, CoreAdminCreateDiscoverTest,
TestReplicationHandlerBackup, HdfsBasicDistributedZkTest, SynonymTokenizerTest,
TestUtils, TestNoOpRegenerator, IndexBasedSpellCheckerTest,
TestExceedMaxTermLength, DistributedFacetPivotSmallAdvancedTest,
TestAnalyzedSuggestions, ExitableDirectoryReaderTest, TestReloadAndDeleteDocs,
TestPhraseSuggestions, BadIndexSchemaTest, TestFastWriter, SolrPluginUtilsTest,
TestJmxIntegration, CurrencyFieldOpenExchangeTest, TestRTGBase,
TermsComponentTest, TestDynamicFieldResource,
TestManagedSchemaFieldTypeResource, BadCopyFieldTest,
DocExpirationUpdateProcessorFactoryTest, HdfsChaosMonkeySafeLeaderTest,
ZkControllerTest, UpdateParamsTest, UniqFieldsUpdateProcessorFactoryTest,
TestStressUserVersions, OutOfBoxZkACLAndCredentialsProvidersTest,
TestWriterPerf, SolrXmlInZkTest, TestSchemaNameResource,
TestFileDictionaryLookup, CloudMLTQParserTest, TestDistribDocBasedVersion,
TestSchemaManager, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test,
UnloadDistributedZkTest, CollectionsAPIDistributedZkTest,
OpenCloseCoreStressTest, LeaderElectionIntegrationTest, BasicZkTest,
RecoveryZkTest, FullSolrCloudDistribCmdsTest, ClusterStateUpdateTest,
TestRandomFaceting, TestZkChroot, ShardRoutingCustomTest,
TestDistributedSearch, AutoCommitTest, TestFaceting, TestHashPartitioner,
TestStressReorder, TestReload, HardAutoCommitTest,
DistributedTermsComponentTest, TestSolr4Spatial, SolrCmdDistributorTest,
ConvertedLegacyTest, TestSort, TestFiltering, TestFunctionQuery,
DirectUpdateHandlerTest, OverseerCollectionProcessorTest,
DistributedQueryElevationComponentTest, SolrIndexSplitterTest,
SimplePostToolTest, TestCoreDiscovery, SignatureUpdateProcessorFactoryTest,
TestExtendedDismaxParser, SpellCheckCollatorTest, SuggesterFSTTest,
CoreAdminHandlerTest, SolrRequestParserTest, TestTrie,
SchemaVersionSpecificBehaviorTest, TestAtomicUpdateErrorCases,
TestWordDelimiterFilterFactory, DirectUpdateHandlerOptimizeTest,
DefaultValueUpdateProcessorTest, DocValuesMultiTest, DistanceFunctionTest,
TestSolrDeletionPolicy1, SolrInfoMBeanTest, XsltUpdateRequestHandlerTest,
CacheHeaderTest, TestSurroundQueryParser, TestQueryUtils,
DocumentAnalysisRequestHandlerTest, PrimitiveFieldTypeTest,
FileBasedSpellCheckerTest, XmlUpdateRequestHandlerTest, RequestHandlersTest,
PathHierarchyTokenizerFactoryTest, MoreLikeThisHandlerTest,
FieldAnalysisRequestHandlerTest, FastVectorHighlighterTest,
IndexSchemaRuntimeFieldTest, LoggingHandlerTest, RegexBoostProcessorTest,
TestCollationField, ReturnFieldsTest, UpdateRequestProcessorFactoryTest,
JSONWriterTest, QueryParsingTest, JsonLoaderTest,
BinaryUpdateRequestHandlerTest, TestPartialUpdateDeduplication,
TestPHPSerializedResponseWriter, PingRequestHandlerTest, TestComponentsName,
SearchHandlerTest, CoreContainerCoreInitFailuresTest, TestBinaryResponseWriter,
SOLR749Test, TestQuerySenderListener, AlternateDirectoryTest,
TestSolrIndexConfig, TestSolrDeletionPolicy2, MultiTermTest, SampleTest,
TestDocSet, TestSearchPerf, NumericFieldsTest, TestElisionMultitermQuery,
TestConfig, ExternalFileFieldSortTest, TestSolrCoreProperties,
TestPostingsSolrHighlighter, NotRequiredUniqueKeyTest,
SpellPossibilityIteratorTest, TestCharFilters, TestCodecSupport,
TestXIncludeConfig, EchoParamsTest, TestSweetSpotSimilarityFactory,
TestPerFieldSimilarity, TestLMJelinekMercerSimilarityFactory,
TestIBSimilarityFactory, TestBM25SimilarityFactory,
LegacyHTMLStripCharFilterTest, TestJmxMonitoredMap, TimeZoneUtilsTest,
ResourceLoaderTest, URLClassifyProcessorTest, PluginInfoTest, TestFastLRUCache,
DateMathParserTest, ChaosMonkeyNothingIsSafeTest, SpellingQueryConverterTest,
TestSolrJ, ZkNodePropsTest, SliceStateTest, SystemInfoHandlerTest,
FileUtilsTest, CircularListTest, CursorPagingTest,
DistributedIntervalFacetingTest, TestHighlightDedupGrouping,
AliasIntegrationTest, CollectionsAPIAsyncDistributedZkTest,
CustomCollectionTest, DeleteInactiveReplicaTest,
DistribDocExpirationUpdateProcessorTest, ExternalCollectionsTest,
LeaderFailoverAfterPartitionTest, MigrateRouteKeyTest,
OverriddenZkACLAndCredentialsProvidersTest, OverseerStatusTest,
ReplicationFactorTest, RollingRestartTest]
[junit4] Completed in 376.15s, 1 test, 1 failure <<< FAILURES!
[...truncated 255 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:525: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:473: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:61: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\extra-targets.xml:39:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:186:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:508:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1358:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:965:
There were test failures: 448 suites, 1821 tests, 1 failure, 54 ignored (30
assumptions)
Total time: 178 minutes 57 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.7.0_67
-XX:-UseCompressedOops -XX:+UseSerialGC (asserts: true)
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
