Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/11626/
Java: 32bit/jdk1.7.0_67 -server -XX:+UseG1GC (asserts: true)
1 tests failed.
REGRESSION: org.apache.solr.search.mlt.CloudMLTQParserTest.testDistribSearch
Error Message:
java.lang.String cannot be cast to java.util.ArrayList
Stack Trace:
java.lang.ClassCastException: java.lang.String cannot be cast to
java.util.ArrayList
at
__randomizedtesting.SeedInfo.seed([47B099DBE8078105:C65617C39F58E139]:0)
at
org.apache.solr.search.mlt.CloudMLTQParserTest.doTest(CloudMLTQParserTest.java:124)
at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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 11218 lines...]
[junit4] Suite: org.apache.solr.search.mlt.CloudMLTQParserTest
[junit4] 2> Creating dataDir:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/init-core-data-001
[junit4] 2> 1028853 T2777 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(false) and clientAuth (false)
[junit4] 2> 1028853 T2777
oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system
property: /zb_pq/j
[junit4] 2> 1028858 T2777 oas.SolrTestCaseJ4.setUp ###Starting
testDistribSearch
[junit4] 2> 1028858 T2777 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1028859 T2778 oasc.ZkTestServer$ZKServerMain.runFromConfig
Starting server
[junit4] 2> 1028959 T2777 oasc.ZkTestServer.run start zk server on
port:35353
[junit4] 2> 1028960 T2777
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1028960 T2777 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1028963 T2784 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@7c5896 name:ZooKeeperConnection
Watcher:127.0.0.1:35353 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1028963 T2777 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1028964 T2777 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1028964 T2777 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 1028967 T2777
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1028969 T2777 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1028969 T2786 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@19f59bb name:ZooKeeperConnection
Watcher:127.0.0.1:35353/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 1028970 T2777 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1028970 T2777 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1028971 T2777 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 1028974 T2777 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 1028977 T2777 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 1028980 T2777 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 1028983 T2777 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 1028984 T2777 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 1028988 T2777 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 1028989 T2777 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 1028993 T2777 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1028994 T2777 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1028997 T2777 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 1028998 T2777 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 1029001 T2777 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 1029002 T2777 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 1029004 T2777 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 1029005 T2777 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 1029008 T2777 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 1029009 T2777 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 1029012 T2777 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 1029012 T2777 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 1029015 T2777 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1029016 T2777 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1029018 T2777 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 1029018 T2777 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 1029021 T2777 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 1029022 T2777 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> 1029407 T2777 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1029412 T2777 oejs.AbstractConnector.doStart Started
[email protected]:53495
[junit4] 2> 1029413 T2777 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 1029413 T2777 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 1029414 T2777 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-002
[junit4] 2> 1029414 T2777 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-002/'
[junit4] 2> 1029433 T2777 oasc.ConfigSolr.fromFile Loading container
configuration from
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-002/solr.xml
[junit4] 2> 1029462 T2777 oasc.CoreContainer.<init> New CoreContainer
8098953
[junit4] 2> 1029463 T2777 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-002/]
[junit4] 2> 1029464 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 1029464 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 1029464 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 1029465 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 1029465 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 1029466 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 1029466 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 1029466 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 1029467 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 1029467 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 1029468 T2777 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 1029468 T2777 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1029469 T2777 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1029469 T2777 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 1029469 T2777 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:35353/solr
[junit4] 2> 1029470 T2777 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 1029470 T2777
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1029471 T2777 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1029472 T2797 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@154e3f6 name:ZooKeeperConnection
Watcher:127.0.0.1:35353 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1029473 T2777 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1029474 T2777 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1029477 T2777 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1029478 T2799 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@798f0b name:ZooKeeperConnection
Watcher:127.0.0.1:35353/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 1029478 T2777 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1029481 T2777 oascc.SolrZkClient.makePath makePath:
/overseer/queue
[junit4] 2> 1029485 T2777 oascc.SolrZkClient.makePath makePath:
/overseer/collection-queue-work
[junit4] 2> 1029489 T2777 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-running
[junit4] 2> 1029493 T2777 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-completed
[junit4] 2> 1029496 T2777 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-failure
[junit4] 2> 1029500 T2777 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 1029503 T2777 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:53495_zb_pq%2Fj
[junit4] 2> 1029504 T2777 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:53495_zb_pq%2Fj
[junit4] 2> 1029508 T2777 oascc.SolrZkClient.makePath makePath:
/overseer_elect
[junit4] 2> 1029510 T2777 oascc.SolrZkClient.makePath makePath:
/overseer_elect/election
[junit4] 2> 1029513 T2777 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 1029515 T2777 oasc.OverseerElectionContext.runLeaderProcess I
am going to be the leader 127.0.0.1:53495_zb_pq%2Fj
[junit4] 2> 1029516 T2777 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 1029519 T2777 oasc.Overseer.start Overseer
(id=92814272273842179-127.0.0.1:53495_zb_pq%2Fj-n_0000000000) starting
[junit4] 2> 1029523 T2777 oascc.SolrZkClient.makePath makePath:
/overseer/queue-work
[junit4] 2> 1029537 T2777 oasc.OverseerAutoReplicaFailoverThread.<init>
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 1029538 T2801 oasc.OverseerCollectionProcessor.run Process
current queue of collection creations
[junit4] 2> 1029539 T2777 oascc.SolrZkClient.makePath makePath:
/clusterstate.json
[junit4] 2> 1029542 T2777 oascc.SolrZkClient.makePath makePath:
/aliases.json
[junit4] 2> 1029545 T2777
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1029551 T2800 oasc.Overseer$ClusterStateUpdater.run Starting
to work on the main queue
[junit4] 2> 1029555 T2803 oasc.ZkController.publish publishing
core=collection1 state=down collection=control_collection
[junit4] 2> 1029555 T2803 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 1029557 T2803 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 1029557 T2804 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1029563 T2800 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=1 message={
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:53495/zb_pq/j";,
[junit4] 2> "numShards":"1",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "core":"collection1",
[junit4] 2> "shard":null,
[junit4] 2> "node_name":"127.0.0.1:53495_zb_pq%2Fj",
[junit4] 2> "state":"down"}
[junit4] 2> 1029563 T2800
oasc.Overseer$ClusterStateUpdater.createCollection Create collection
control_collection with shards [shard1]
[junit4] 2> 1029563 T2800
oasc.Overseer$ClusterStateUpdater.createCollection state version
control_collection 1
[junit4] 2> 1029564 T2800 oasc.Overseer$ClusterStateUpdater.updateState
Assigning new node to shard shard=shard1
[junit4] 2> 1029567 T2804 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> 1030557 T2803 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for collection1
[junit4] 2> 1030558 T2803 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:control_collection
[junit4] 2> 1030559 T2803 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 1030559 T2803 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/control_collection
[junit4] 2> 1030561 T2803 oascc.ZkStateReader.readConfigName
path=/collections/control_collection configName=conf1 specified config exists
in ZooKeeper
[junit4] 2> 1030561 T2803 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-002/collection1/'
[junit4] 2> 1030562 T2803 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-002/collection1/lib/.svn/'
to classloader
[junit4] 2> 1030562 T2803 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-002/collection1/lib/classes/'
to classloader
[junit4] 2> 1030563 T2803 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-002/collection1/lib/README'
to classloader
[junit4] 2> 1030622 T2803 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 6.0.0
[junit4] 2> 1030676 T2803 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 1030677 T2803 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 1030686 T2803 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 1030956 T2803 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1030960 T2803 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 1030962 T2803 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1030971 T2803 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1030974 T2803 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1030976 T2803 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1030977 T2803
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1030977 T2803
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1030977 T2803 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1030978 T2803
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1030978 T2803
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1030979 T2803 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection control_collection
[junit4] 2> 1030979 T2803 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1030979 T2803 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-002/collection1/,
dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-001/control/data/
[junit4] 2> 1030979 T2803 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1da0143
[junit4] 2> 1030980 T2803 oasc.CachingDirectoryFactory.get return new
directory for
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-001/control/data
[junit4] 2> 1030980 T2803 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-001/control/data/index/
[junit4] 2> 1030981 T2803 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-001/control/data/index'
doesn't exist. Creating new index...
[junit4] 2> 1030981 T2803 oasc.CachingDirectoryFactory.get return new
directory for
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-001/control/data/index
[junit4] 2> 1030982 T2803 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=36, maxMergeAtOnceExplicit=10, maxMergedSegmentMB=79.8798828125,
floorSegmentMB=1.125, forceMergeDeletesPctAllowed=18.8949318909279,
segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.7281777660785291
[junit4] 2> 1031084 T2803 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(SimpleFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/index-SimpleFSDirectory-001
lockFactory=org.apache.lucene.store.NativeFSLockFactory@b8fba9)),segFN=segments_1,generation=1}
[junit4] 2> 1031085 T2803 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 1031086 T2803 oasc.SolrCore.initWriters created xml:
solr.XMLResponseWriter
[junit4] 2> 1031092 T2803 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 1031093 T2803 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1031093 T2803 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 1031094 T2803 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 1031094 T2803 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 1031095 T2803 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1031095 T2803 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "uniq-fields"
[junit4] 2> 1031096 T2803 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 1031096 T2803 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1031097 T2803 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1031097 T2803 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 1031098 T2803 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1031099 T2803 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1031099 T2803 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 1031100 T2803 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1031100 T2803 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1031100 T2803 oasc.RequestHandlers.initHandlersFromConfig
adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 1031100 T2803 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 1031101 T2803 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 1031101 T2803 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 1031101 T2803 oasc.RequestHandlers.initHandlersFromConfig
created dismax: solr.SearchHandler
[junit4] 2> 1031102 T2803 oasc.RequestHandlers.initHandlersFromConfig
created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 1031102 T2803 oasc.RequestHandlers.initHandlersFromConfig
created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 1031102 T2803 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 1031103 T2803 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 1031103 T2803 oasc.RequestHandlers.initHandlersFromConfig
created defaults: solr.StandardRequestHandler
[junit4] 2> 1031103 T2803 oasc.RequestHandlers.initHandlersFromConfig
adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 1031103 T2803 oasc.RequestHandlers.initHandlersFromConfig
created lazy: solr.StandardRequestHandler
[junit4] 2> 1031104 T2803 oasc.RequestHandlers.initHandlersFromConfig
created /update: solr.UpdateRequestHandler
[junit4] 2> 1031104 T2803 oasc.RequestHandlers.initHandlersFromConfig
created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1031105 T2803 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1031105 T2803 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1031105 T2803 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1031105 T2803 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckWithWordbreak_Direct:
org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1031106 T2803 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1031106 T2803 oasc.RequestHandlers.initHandlersFromConfig
created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1031106 T2803 oasc.RequestHandlers.initHandlersFromConfig
created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1031107 T2803 oasc.RequestHandlers.initHandlersFromConfig
created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 1031107 T2803 oasc.RequestHandlers.initHandlersFromConfig
created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 1031110 T2803 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1031111 T2803 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1031111 T2803 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1031112 T2803 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1031113 T2803 oasc.SolrCore.initDeprecatedSupport WARN
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config
to use the ShowFileRequestHandler.
[junit4] 2> 1031115 T2803 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 1031116 T2803 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 1031116 T2803 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=13,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1031117 T2803 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(SimpleFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/index-SimpleFSDirectory-001
lockFactory=org.apache.lucene.store.NativeFSLockFactory@b8fba9)),segFN=segments_1,generation=1}
[junit4] 2> 1031118 T2803 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 1031118 T2803 oass.SolrIndexSearcher.<init> Opening
Searcher@1d1be3e[collection1] main
[junit4] 2> 1031118 T2803 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/control_collection
[junit4] 2> 1031119 T2803 oascc.ZkStateReader.readConfigName
path=/collections/control_collection configName=conf1 specified config exists
in ZooKeeper
[junit4] 2> 1031119 T2803 oasr.RestManager.init Initializing RestManager
with initArgs:
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 1031119 T2803 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using InMemoryStorage
[junit4] 2> 1031120 T2803 oasr.ManagedResource.reloadFromStorage WARN No
stored data found for /rest/managed
[junit4] 2> 1031120 T2803 oasr.ManagedResourceStorage$JsonStorage.store
Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 1031120 T2803 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 1031120 T2803 oashc.SpellCheckComponent.inform Initializing
spell checkers
[junit4] 2> 1031123 T2803 oass.DirectSolrSpellChecker.init init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1031142 T2805 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@1d1be3e[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1031148 T2803 oasc.CoreContainer.registerCore registering
core: collection1
[junit4] 2> 1031149 T2808 oasc.ZkController.register Register replica -
core:collection1 address:http://127.0.0.1:53495/zb_pq/j
collection:control_collection shard:shard1
[junit4] 2> 1031149 T2777 oass.SolrDispatchFilter.init
user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0
[junit4] 2> 1031150 T2808 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/leader_elect/shard1/election
[junit4] 2> 1031150 T2777 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 1031151 T2777
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1031151 T2777 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1031152 T2810 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@189f741 name:ZooKeeperConnection
Watcher:127.0.0.1:35353/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 1031153 T2777 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1031153 T2777 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1031155 T2777
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1031155 T2808 oasc.ShardLeaderElectionContext.runLeaderProcess
Running the leader process for shard shard1
[junit4] 2> 1031157 T2804 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1031157 T2808
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 1031157 T2808 oasc.ShardLeaderElectionContext.runLeaderProcess
I may be the new leader - try and sync
[junit4] 2> ASYNC NEW_CORE C541 name=collection1
org.apache.solr.core.SolrCore@71924c
url=http://127.0.0.1:53495/zb_pq/j/collection1 node=127.0.0.1:53495_zb_pq%2Fj
C541_STATE=coll:control_collection core:collection1
props:{base_url=http://127.0.0.1:53495/zb_pq/j, core=collection1,
node_name=127.0.0.1:53495_zb_pq%2Fj, state=down}
[junit4] 2> 1031157 T2808 C541 P53495 oasc.SyncStrategy.sync Sync replicas
to http://127.0.0.1:53495/zb_pq/j/collection1/
[junit4] 2> 1031158 T2808 C541 P53495 oasc.SyncStrategy.syncReplicas Sync
Success - now sync replicas to me
[junit4] 2> 1031158 T2777 oasc.ChaosMonkey.monkeyLog monkey: init - expire
sessions:false cause connection loss:false
[junit4] 2> 1031158 T2808 C541 P53495 oasc.SyncStrategy.syncToMe
http://127.0.0.1:53495/zb_pq/j/collection1/ has no replicas
[junit4] 2> 1031159 T2808 oasc.ShardLeaderElectionContext.runLeaderProcess
I am the new leader: http://127.0.0.1:53495/zb_pq/j/collection1/ shard1
[junit4] 2> 1031159 T2808 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/leaders/shard1
[junit4] 2> 1031160 T2804 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> 1031160 T2811 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> 1031162 T2812 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1031266 T2812 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> 1031266 T2811 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> 1031313 T2808 oasc.ZkController.register We are
http://127.0.0.1:53495/zb_pq/j/collection1/ and leader is
http://127.0.0.1:53495/zb_pq/j/collection1/
[junit4] 2> 1031314 T2808 oasc.ZkController.register No LogReplay needed
for core=collection1 baseURL=http://127.0.0.1:53495/zb_pq/j
[junit4] 2> 1031314 T2808 oasc.ZkController.checkRecovery I am the leader,
no recovery necessary
[junit4] 2> 1031314 T2808 oasc.ZkController.publish publishing
core=collection1 state=active collection=control_collection
[junit4] 2> 1031314 T2808 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 1031315 T2812 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1031318 T2800 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "roles":null,
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "base_url":"http://127.0.0.1:53495/zb_pq/j";,
[junit4] 2> "numShards":"2",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "core":"collection1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "node_name":"127.0.0.1:53495_zb_pq%2Fj",
[junit4] 2> "state":"active"}
[junit4] 2> 1031416 T2777 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1
[junit4] 2> 1031417 T2777 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1031418 T2777 oejs.AbstractConnector.doStart Started
[email protected]:60581
[junit4] 2> 1031419 T2777 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 1031420 T2777 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 1031420 T2812 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> 1031420 T2811 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> 1031420 T2777 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-003
[junit4] 2> 1031421 T2777 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-003/'
[junit4] 2> 1031434 T2777 oasc.ConfigSolr.fromFile Loading container
configuration from
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-003/solr.xml
[junit4] 2> 1031461 T2777 oasc.CoreContainer.<init> New CoreContainer
20318169
[junit4] 2> 1031461 T2777 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-003/]
[junit4] 2> 1031462 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 1031463 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 1031463 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 1031463 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 1031464 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 1031464 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 1031464 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 1031465 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 1031465 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 1031465 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 1031466 T2777 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 1031466 T2777 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1031466 T2777 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1031467 T2777 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 1031467 T2777 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:35353/solr
[junit4] 2> 1031467 T2777 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 1031468 T2777
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1031468 T2777 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1031470 T2823 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@3d6343 name:ZooKeeperConnection
Watcher:127.0.0.1:35353 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1031470 T2777 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1031471 T2777 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1031473 T2777 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1031474 T2825 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@bd40c6 name:ZooKeeperConnection
Watcher:127.0.0.1:35353/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 1031474 T2777 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1031478 T2777
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1032481 T2777 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60581_zb_pq%2Fj
[junit4] 2> 1032482 T2777 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:60581_zb_pq%2Fj
[junit4] 2> 1032486 T2777 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 1032490 T2827 oasc.ZkController.publish publishing
core=collection1 state=down collection=collection1
[junit4] 2> 1032490 T2827 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 1032491 T2812 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1032491 T2827 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 1032493 T2800 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:60581/zb_pq/j";,
[junit4] 2> "numShards":"2",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"collection1",
[junit4] 2> "core":"collection1",
[junit4] 2> "shard":null,
[junit4] 2> "node_name":"127.0.0.1:60581_zb_pq%2Fj",
[junit4] 2> "state":"down"}
[junit4] 2> 1032493 T2800
oasc.Overseer$ClusterStateUpdater.createCollection Create collection
collection1 with shards [shard1, shard2]
[junit4] 2> 1032493 T2800
oasc.Overseer$ClusterStateUpdater.createCollection state version collection1 1
[junit4] 2> 1032493 T2800 oasc.Overseer$ClusterStateUpdater.updateState
Assigning new node to shard shard=shard2
[junit4] 2> 1032596 T2826 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> 1032596 T2811 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> 1032596 T2812 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> 1033491 T2827 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for collection1
[junit4] 2> 1033492 T2827 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:collection1
[junit4] 2> 1033493 T2827 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 1033493 T2827 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 1033494 T2827 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 1033494 T2827 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-003/collection1/'
[junit4] 2> 1033495 T2827 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-003/collection1/lib/.svn/'
to classloader
[junit4] 2> 1033496 T2827 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-003/collection1/lib/classes/'
to classloader
[junit4] 2> 1033496 T2827 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-003/collection1/lib/README'
to classloader
[junit4] 2> 1033543 T2827 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 6.0.0
[junit4] 2> 1033585 T2827 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 1033586 T2827 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 1033592 T2827 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 1033803 T2827 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1033808 T2827 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 1033810 T2827 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1033818 T2827 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1033821 T2827 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1033824 T2827 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1033825 T2827
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1033826 T2827
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1033826 T2827 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1033827 T2827
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1033828 T2827
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1033828 T2827 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection collection1
[junit4] 2> 1033828 T2827 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1033828 T2827 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-003/collection1/,
dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-001/jetty1/
[junit4] 2> 1033829 T2827 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1da0143
[junit4] 2> 1033829 T2827 oasc.CachingDirectoryFactory.get return new
directory for
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-001/jetty1
[junit4] 2> 1033830 T2827 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-001/jetty1/index/
[junit4] 2> 1033830 T2827 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-001/jetty1/index'
doesn't exist. Creating new index...
[junit4] 2> 1033831 T2827 oasc.CachingDirectoryFactory.get return new
directory for
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-001/jetty1/index
[junit4] 2> 1033831 T2827 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=36, maxMergeAtOnceExplicit=10, maxMergedSegmentMB=79.8798828125,
floorSegmentMB=1.125, forceMergeDeletesPctAllowed=18.8949318909279,
segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.7281777660785291
[junit4] 2> 1033838 T2827 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(SimpleFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/index-SimpleFSDirectory-002
lockFactory=org.apache.lucene.store.NativeFSLockFactory@b8fba9)),segFN=segments_1,generation=1}
[junit4] 2> 1033839 T2827 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 1033840 T2827 oasc.SolrCore.initWriters created xml:
solr.XMLResponseWriter
[junit4] 2> 1033845 T2827 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 1033846 T2827 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1033846 T2827 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 1033846 T2827 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 1033847 T2827 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 1033847 T2827 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1033847 T2827 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "uniq-fields"
[junit4] 2> 1033848 T2827 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 1033848 T2827 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1033849 T2827 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1033849 T2827 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 1033850 T2827 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1033850 T2827 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1033851 T2827 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 1033851 T2827 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1033852 T2827 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1033852 T2827 oasc.RequestHandlers.initHandlersFromConfig
adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 1033853 T2827 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 1033853 T2827 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 1033854 T2827 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 1033854 T2827 oasc.RequestHandlers.initHandlersFromConfig
created dismax: solr.SearchHandler
[junit4] 2> 1033855 T2827 oasc.RequestHandlers.initHandlersFromConfig
created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 1033855 T2827 oasc.RequestHandlers.initHandlersFromConfig
created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 1033856 T2827 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 1033856 T2827 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 1033857 T2827 oasc.RequestHandlers.initHandlersFromConfig
created defaults: solr.StandardRequestHandler
[junit4] 2> 1033857 T2827 oasc.RequestHandlers.initHandlersFromConfig
adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 1033857 T2827 oasc.RequestHandlers.initHandlersFromConfig
created lazy: solr.StandardRequestHandler
[junit4] 2> 1033858 T2827 oasc.RequestHandlers.initHandlersFromConfig
created /update: solr.UpdateRequestHandler
[junit4] 2> 1033859 T2827 oasc.RequestHandlers.initHandlersFromConfig
created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1033859 T2827 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1033859 T2827 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1033860 T2827 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1033860 T2827 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckWithWordbreak_Direct:
org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1033861 T2827 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1033861 T2827 oasc.RequestHandlers.initHandlersFromConfig
created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1033861 T2827 oasc.RequestHandlers.initHandlersFromConfig
created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1033862 T2827 oasc.RequestHandlers.initHandlersFromConfig
created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 1033862 T2827 oasc.RequestHandlers.initHandlersFromConfig
created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 1033865 T2827 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1033866 T2827 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1033867 T2827 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1033868 T2827 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1033869 T2827 oasc.SolrCore.initDeprecatedSupport WARN
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config
to use the ShowFileRequestHandler.
[junit4] 2> 1033870 T2827 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 1033870 T2827 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 1033902 T2827 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=13,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1033903 T2827 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(SimpleFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/index-SimpleFSDirectory-002
lockFactory=org.apache.lucene.store.NativeFSLockFactory@b8fba9)),segFN=segments_1,generation=1}
[junit4] 2> 1033904 T2827 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 1033904 T2827 oass.SolrIndexSearcher.<init> Opening
Searcher@1aa7161[collection1] main
[junit4] 2> 1033904 T2827 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 1033905 T2827 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 1033906 T2827 oasr.RestManager.init Initializing RestManager
with initArgs:
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 1033906 T2827 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using InMemoryStorage
[junit4] 2> 1033906 T2827 oasr.ManagedResource.reloadFromStorage WARN No
stored data found for /rest/managed
[junit4] 2> 1033907 T2827 oasr.ManagedResourceStorage$JsonStorage.store
Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 1033907 T2827 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 1033907 T2827 oashc.SpellCheckComponent.inform Initializing
spell checkers
[junit4] 2> 1033911 T2827 oass.DirectSolrSpellChecker.init init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1033936 T2828 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@1aa7161[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1033944 T2827 oasc.CoreContainer.registerCore registering
core: collection1
[junit4] 2> 1033945 T2831 oasc.ZkController.register Register replica -
core:collection1 address:http://127.0.0.1:60581/zb_pq/j collection:collection1
shard:shard2
[junit4] 2> 1033945 T2777 oass.SolrDispatchFilter.init
user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0
[junit4] 2> 1033946 T2777 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 1033946 T2831 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leader_elect/shard2/election
[junit4] 2> 1033950 T2831 oasc.ShardLeaderElectionContext.runLeaderProcess
Running the leader process for shard shard2
[junit4] 2> 1033952 T2812 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1033952 T2831
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 1033952 T2831 oasc.ShardLeaderElectionContext.runLeaderProcess
I may be the new leader - try and sync
[junit4] 2> ASYNC NEW_CORE C542 name=collection1
org.apache.solr.core.SolrCore@152fb3a
url=http://127.0.0.1:60581/zb_pq/j/collection1 node=127.0.0.1:60581_zb_pq%2Fj
C542_STATE=coll:collection1 core:collection1
props:{base_url=http://127.0.0.1:60581/zb_pq/j, core=collection1,
node_name=127.0.0.1:60581_zb_pq%2Fj, state=down}
[junit4] 2> 1033952 T2831 C542 P60581 oasc.SyncStrategy.sync Sync replicas
to http://127.0.0.1:60581/zb_pq/j/collection1/
[junit4] 2> 1033952 T2831 C542 P60581 oasc.SyncStrategy.syncReplicas Sync
Success - now sync replicas to me
[junit4] 2> 1033953 T2831 C542 P60581 oasc.SyncStrategy.syncToMe
http://127.0.0.1:60581/zb_pq/j/collection1/ has no replicas
[junit4] 2> 1033953 T2831 oasc.ShardLeaderElectionContext.runLeaderProcess
I am the new leader: http://127.0.0.1:60581/zb_pq/j/collection1/ shard2
[junit4] 2> 1033953 T2831 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leaders/shard2
[junit4] 2> 1033957 T2812 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1034059 T2812 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> 1034060 T2826 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> 1034060 T2811 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> 1034108 T2831 oasc.ZkController.register We are
http://127.0.0.1:60581/zb_pq/j/collection1/ and leader is
http://127.0.0.1:60581/zb_pq/j/collection1/
[junit4] 2> 1034108 T2831 oasc.ZkController.register No LogReplay needed
for core=collection1 baseURL=http://127.0.0.1:60581/zb_pq/j
[junit4] 2> 1034108 T2831 oasc.ZkController.checkRecovery I am the leader,
no recovery necessary
[junit4] 2> 1034109 T2831 oasc.ZkController.publish publishing
core=collection1 state=active collection=collection1
[junit4] 2> 1034109 T2831 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 1034111 T2812 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1034113 T2800 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "roles":null,
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "base_url":"http://127.0.0.1:60581/zb_pq/j";,
[junit4] 2> "numShards":"2",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"collection1",
[junit4] 2> "core":"collection1",
[junit4] 2> "shard":"shard2",
[junit4] 2> "node_name":"127.0.0.1:60581_zb_pq%2Fj",
[junit4] 2> "state":"active"}
[junit4] 2> 1034208 T2777 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2
[junit4] 2> 1034209 T2777 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1034211 T2777 oejs.AbstractConnector.doStart Started
[email protected]:60451
[junit4] 2> 1034212 T2777 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 1034212 T2777 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 1034213 T2777 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-004
[junit4] 2> 1034213 T2777 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-004/'
[junit4] 2> 1034215 T2812 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> 1034215 T2826 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> 1034215 T2811 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> 1034226 T2777 oasc.ConfigSolr.fromFile Loading container
configuration from
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-004/solr.xml
[junit4] 2> 1034253 T2777 oasc.CoreContainer.<init> New CoreContainer
8260393
[junit4] 2> 1034254 T2777 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-004/]
[junit4] 2> 1034255 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 1034255 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 1034255 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 1034256 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 1034256 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 1034256 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 1034257 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 1034257 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 1034257 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 1034258 T2777 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 1034258 T2777 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 1034258 T2777 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1034259 T2777 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1034259 T2777 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 1034260 T2777 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:35353/solr
[junit4] 2> 1034260 T2777 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 1034260 T2777
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1034261 T2777 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1034262 T2842 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@17895c3 name:ZooKeeperConnection
Watcher:127.0.0.1:35353 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1034263 T2777 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1034263 T2777 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1034265 T2777 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1034266 T2844 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@f289a9 name:ZooKeeperConnection
Watcher:127.0.0.1:35353/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 1034266 T2777 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1034271 T2777
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1035274 T2777 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60451_zb_pq%2Fj
[junit4] 2> 1035276 T2777 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:60451_zb_pq%2Fj
[junit4] 2> 1035281 T2777 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 1035289 T2846 oasc.ZkController.publish publishing
core=collection1 state=down collection=collection1
[junit4] 2> 1035289 T2846 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 1035290 T2812 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1035290 T2846 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 1035294 T2800 oasc.Overseer$ClusterStateUpdater.updateState
Update state numShards=2 message={
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:60451/zb_pq/j";,
[junit4] 2> "numShards":"2",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"collection1",
[junit4] 2> "core":"collection1",
[junit4] 2> "shard":null,
[junit4] 2> "node_name":"127.0.0.1:60451_zb_pq%2Fj",
[junit4] 2> "state":"down"}
[junit4] 2> 1035294 T2800 oasc.Overseer$ClusterStateUpdater.updateState
Collection already exists with numShards=2
[junit4] 2> 1035294 T2800 oasc.Overseer$ClusterStateUpdater.updateState
Assigning new node to shard shard=shard1
[junit4] 2> 1035398 T2812 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> 1035398 T2845 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> 1035398 T2811 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> 1035398 T2826 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> 1036291 T2846 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for collection1
[junit4] 2> 1036291 T2846 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:collection1
[junit4] 2> 1036292 T2846 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 1036293 T2846 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 1036294 T2846 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 1036295 T2846 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-004/collection1/'
[junit4] 2> 1036296 T2846 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-004/collection1/lib/.svn/'
to classloader
[junit4] 2> 1036296 T2846 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-004/collection1/lib/classes/'
to classloader
[junit4] 2> 1036297 T2846 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-004/collection1/lib/README'
to classloader
[junit4] 2> 1036348 T2846 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 6.0.0
[junit4] 2> 1036391 T2846 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 1036392 T2846 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 1036398 T2846 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 1036675 T2846 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1036680 T2846 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 1036682 T2846 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1036691 T2846 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1036694 T2846 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1036696 T2846 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1036697 T2846
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1036698 T2846
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1036698 T2846 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1036699 T2846
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1036699 T2846
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1036699 T2846 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection collection1
[junit4] 2> 1036699 T2846 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1036700 T2846 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-004/collection1/,
dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-001/jetty2/
[junit4] 2> 1036700 T2846 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1da0143
[junit4] 2> 1036700 T2846 oasc.CachingDirectoryFactory.get return new
directory for
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-001/jetty2
[junit4] 2> 1036701 T2846 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-001/jetty2/index/
[junit4] 2> 1036701 T2846 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-001/jetty2/index'
doesn't exist. Creating new index...
[junit4] 2> 1036702 T2846 oasc.CachingDirectoryFactory.get return new
directory for
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-001/jetty2/index
[junit4] 2> 1036702 T2846 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=36, maxMergeAtOnceExplicit=10, maxMergedSegmentMB=79.8798828125,
floorSegmentMB=1.125, forceMergeDeletesPctAllowed=18.8949318909279,
segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.7281777660785291
[junit4] 2> 1036708 T2846 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(SimpleFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/index-SimpleFSDirectory-003
lockFactory=org.apache.lucene.store.NativeFSLockFactory@b8fba9)),segFN=segments_1,generation=1}
[junit4] 2> 1036708 T2846 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 1036709 T2846 oasc.SolrCore.initWriters created xml:
solr.XMLResponseWriter
[junit4] 2> 1036712 T2846 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 1036713 T2846 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1036713 T2846 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 1036713 T2846 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 1036713 T2846 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 1036713 T2846 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1036714 T2846 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "uniq-fields"
[junit4] 2> 1036714 T2846 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 1036714 T2846 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1036714 T2846 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1036715 T2846 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 1036715 T2846 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1036715 T2846 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1036716 T2846 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 1036716 T2846 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1036717 T2846 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1036717 T2846 oasc.RequestHandlers.initHandlersFromConfig
adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 1036717 T2846 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 1036717 T2846 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 1036718 T2846 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 1036718 T2846 oasc.RequestHandlers.initHandlersFromConfig
created dismax: solr.SearchHandler
[junit4] 2> 1036719 T2846 oasc.RequestHandlers.initHandlersFromConfig
created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 1036719 T2846 oasc.RequestHandlers.initHandlersFromConfig
created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 1036719 T2846 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 1036720 T2846 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 1036720 T2846 oasc.RequestHandlers.initHandlersFromConfig
created defaults: solr.StandardRequestHandler
[junit4] 2> 1036720 T2846 oasc.RequestHandlers.initHandlersFromConfig
adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 1036721 T2846 oasc.RequestHandlers.initHandlersFromConfig
created lazy: solr.StandardRequestHandler
[junit4] 2> 1036721 T2846 oasc.RequestHandlers.initHandlersFromConfig
created /update: solr.UpdateRequestHandler
[junit4] 2> 1036721 T2846 oasc.RequestHandlers.initHandlersFromConfig
created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1036722 T2846 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1036722 T2846 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1036722 T2846 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1036723 T2846 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckWithWordbreak_Direct:
org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1036723 T2846 oasc.RequestHandlers.initHandlersFromConfig
created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1036724 T2846 oasc.RequestHandlers.initHandlersFromConfig
created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1036724 T2846 oasc.RequestHandlers.initHandlersFromConfig
created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1036724 T2846 oasc.RequestHandlers.initHandlersFromConfig
created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 1036725 T2846 oasc.RequestHandlers.initHandlersFromConfig
created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 1036727 T2846 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1036728 T2846 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1036729 T2846 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1036730 T2846 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1036731 T2846 oasc.SolrCore.initDeprecatedSupport WARN
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config
to use the ShowFileRequestHandler.
[junit4] 2> 1036733 T2846 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 1036733 T2846 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 1036734 T2846 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=13,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1036735 T2846 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(SimpleFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/index-SimpleFSDirectory-003
lockFactory=org.apache.lucene.store.NativeFSLockFactory@b8fba9)),segFN=segments_1,generation=1}
[junit4] 2> 1036735 T2846 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 1036735 T2846 oass.SolrIndexSearcher.<init> Opening
Searcher@38cb9c[collection1] main
[junit4] 2> 1036736 T2846 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 1036737 T2846 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 1036737 T2846 oasr.RestManager.init Initializing RestManager
with initArgs:
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 1036737 T2846 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using InMemoryStorage
[junit4] 2> 1036737 T2846 oasr.ManagedResource.reloadFromStorage WARN No
stored data found for /rest/managed
[junit4] 2> 1036737 T2846 oasr.ManagedResourceStorage$JsonStorage.store
Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 1036738 T2846 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 1036738 T2846 oashc.SpellCheckComponent.inform Initializing
spell checkers
[junit4] 2> 1036741 T2846 oass.DirectSolrSpellChecker.init init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1036762 T2847 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@38cb9c[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1036768 T2846 oasc.CoreContainer.registerCore registering
core: collection1
[junit4] 2> 1036769 T2850 oasc.ZkController.register Register replica -
core:collection1 address:http://127.0.0.1:60451/zb_pq/j collection:collection1
shard:shard1
[junit4] 2> 1036769 T2777 oass.SolrDispatchFilter.init
user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0
[junit4] 2> 1036770 T2777 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 1036770 T2850 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leader_elect/shard1/election
[junit4] 2> 1036773 T2850 oasc.ShardLeaderElectionContext.runLeaderProcess
Running the leader process for shard shard1
[junit4] 2> 1036775 T2812 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1036775 T2850
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 1036775 T2850 oasc.ShardLeaderElectionContext.runLeaderProcess
I may be the new leader - try and sync
[junit4] 2> ASYNC NEW_CORE C543 name=collection1
org.apache.solr.core.SolrCore@91a724
url=http://127.0.0.1:60451/zb_pq/j/collection1 node=127.0.0.1:60451_zb_pq%2Fj
C543_S
[...truncated too long message...]
sting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 1071678 T2777 oasc.CachingDirectoryFactory.close Closing
MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 1071679 T2777 oasc.CachingDirectoryFactory.closeCacheValue
looking to close
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-001/jetty4/index
[CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-001/jetty4/index;done=false>>]
[junit4] 2> 1071679 T2777 oasc.CachingDirectoryFactory.close Closing
directory:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-001/jetty4/index
[junit4] 2> 1071680 T2777 oasc.CachingDirectoryFactory.closeCacheValue
looking to close
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-001/jetty4
[CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-001/jetty4;done=false>>]
[junit4] 2> 1071680 T2777 oasc.CachingDirectoryFactory.close Closing
directory:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001/tempDir-001/jetty4
[junit4] 2> 1071681 T2777 oasc.Overseer.close Overseer
(id=92814272273842188-127.0.0.1:47011_zb_pq%2Fj-n_0000000004) closing
[junit4] 2> 1071682 T2922 oasc.Overseer$ClusterStateUpdater.run Overseer
Loop exiting : 127.0.0.1:47011_zb_pq%2Fj
[junit4] 2> 1071684 T2884 oaz.ClientCnxn$EventThread.processEvent ERROR
Error while calling watcher java.util.concurrent.RejectedExecutionException:
Task java.util.concurrent.FutureTask@1fe6b85 rejected from
java.util.concurrent.ThreadPoolExecutor@450267[Terminated, pool size = 0,
active threads = 0, queued tasks = 0, completed tasks = 20]
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2048)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:821)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1372)
[junit4] 2> at
java.util.concurrent.AbstractExecutorService.submit(AbstractExecutorService.java:110)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$3.process(SolrZkClient.java:264)
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522)
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498)
[junit4] 2>
[junit4] 2> 1071708 T2777 oejsh.ContextHandler.doStop stopped
o.e.j.s.ServletContextHandler{/zb_pq/j,null}
[junit4] 2> 1076697 T2777 oas.SolrTestCaseJ4.tearDown ###Ending
testDistribSearch
[junit4] 2> 1076699 T2777 oasc.ZkTestServer.send4LetterWord connecting to
127.0.0.1:35353 35353
[junit4] 2> 1077349 T2778 oasc.ZkTestServer.send4LetterWord connecting to
127.0.0.1:35353 35353
[junit4] 2> 1077350 T2778 oasc.ZkTestServer$ZKServerMain.runFromConfig
WARN Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 6 /solr/aliases.json
[junit4] 2> 6 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 6 /solr/live_nodes
[junit4] 2> 5 /solr/overseer/collection-queue-work
[junit4] 2> 5 /solr/configs/conf1
[junit4] 2> 5 /solr/overseer/queue
[junit4] 2>
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=CloudMLTQParserTest
-Dtests.method=testDistribSearch -Dtests.seed=47B099DBE8078105
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=zh
-Dtests.timezone=America/Louisville -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] ERROR 48.5s J0 | CloudMLTQParserTest.testDistribSearch <<<
[junit4] > Throwable #1: java.lang.ClassCastException: java.lang.String
cannot be cast to java.util.ArrayList
[junit4] > at
__randomizedtesting.SeedInfo.seed([47B099DBE8078105:C65617C39F58E139]:0)
[junit4] > at
org.apache.solr.search.mlt.CloudMLTQParserTest.doTest(CloudMLTQParserTest.java:124)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 1077357 T2777 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest-47B099DBE8078105-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50):
{lowerfilt=PostingsFormat(name=Memory doPackFST= true),
id=PostingsFormat(name=Direct), timestamp=PostingsFormat(name=Memory doPackFST=
true), intDefault=PostingsFormat(name=Memory doPackFST= false),
lowerfilt1and2=PostingsFormat(name=Memory doPackFST= true),
multiDefault=PostingsFormat(name=Memory doPackFST= true),
range_facet_l=PostingsFormat(name=Memory doPackFST= true),
_version_=PostingsFormat(name=Memory doPackFST= false)},
docValues:{timestamp=DocValuesFormat(name=Asserting)},
sim=RandomSimilarityProvider(queryNorm=true,coord=no): {}, locale=zh,
timezone=America/Louisville
[junit4] 2> NOTE: Linux 3.13.0-39-generic i386/Oracle Corporation 1.7.0_67
(32-bit)/cpus=8,threads=1,free=90631088,total=510656512
[junit4] 2> NOTE: All tests run in this JVM: [TestBinaryResponseWriter,
SyncSliceTest, TestFastWriter, TestWordDelimiterFilterFactory,
TestCoreDiscovery, AnalysisErrorHandlingTest, TestChildDocTransformer,
TestAnalyzedSuggestions, TestStressVersions, HdfsSyncSliceTest,
TestNonDefinedSimilarityFactory, TestOrdValues, TestRTGBase,
BasicFunctionalityTest, HdfsRecoveryZkTest, QueryEqualityTest,
DistributedQueryComponentOptimizationTest, CustomCollectionTest,
TestIntervalFaceting, XmlUpdateRequestHandlerTest, CoreAdminHandlerTest,
ExitableDirectoryReaderTest, ZkControllerTest, ReplicationFactorTest,
OverseerCollectionProcessorTest, TestPartialUpdateDeduplication,
DocumentBuilderTest, TestSystemIdResolver, TestConfig, TestComponentsName,
TestModifyConfFiles, JsonLoaderTest, SpellCheckCollatorTest, ShardRoutingTest,
TestLuceneMatchVersion, TestOverriddenPrefixQueryForCustomFieldType,
TestSolrQueryParserDefaultOperatorResource, UnloadDistributedZkTest,
SuggesterTSTTest, DirectUpdateHandlerTest, PingRequestHandlerTest,
TestManagedResource, DeleteInactiveReplicaTest, TestFaceting,
TestArbitraryIndexDir, VMParamsZkACLAndCredentialsProvidersTest,
TestStressRecovery, HdfsUnloadDistributedZkTest, TestShardHandlerFactory,
TestDistributedSearch, TestDocBasedVersionConstraints, TestFieldResource,
TestAddFieldRealTimeGet, TestShortCircuitedRequests, SolrCmdDistributorTest,
StatelessScriptUpdateProcessorFactoryTest, AtomicUpdatesTest,
DateRangeFieldTest, RegexBoostProcessorTest, CloudMLTQParserTest]
[junit4] Completed on J0 in 48.54s, 1 test, 1 error <<< FAILURES!
[...truncated 958 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:525: The following
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:473: The following
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:61: The following
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/extra-targets.xml:39: The
following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:186: The
following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:508:
The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1358:
The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:965:
There were test failures: 447 suites, 1820 tests, 1 error, 45 ignored (21
assumptions)
Total time: 111 minutes 6 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 32bit/jdk1.7.0_67 -server
-XX:+UseG1GC (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]
