Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Linux/11560/
Java: 32bit/jdk1.7.0_80-ea-b05 -server -XX:+UseSerialGC
1 tests failed.
FAILED: org.apache.solr.handler.TestBlobHandler.doBlobHandlerTest
Error Message:
{responseHeader={status=0, QTime=1}, response={numFound=0, start=0, docs=[]}}
Stack Trace:
java.lang.AssertionError: {responseHeader={status=0, QTime=1},
response={numFound=0, start=0, docs=[]}}
at
__randomizedtesting.SeedInfo.seed([4A617A95729D091C:AAA058C7C9717FEE]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.handler.TestBlobHandler.doBlobHandlerTest(TestBlobHandler.java:96)
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
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:940)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:915)
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 9636 lines...]
[junit4] Suite: org.apache.solr.handler.TestBlobHandler
[junit4] 2> Creating dataDir:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/init-core-data-001
[junit4] 2> 1003204 T4821 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(false) and clientAuth (false)
[junit4] 2> 1003205 T4821
oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system
property: /o/ke
[junit4] 2> 1003208 T4821 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1003209 T4822 oasc.ZkTestServer$ZKServerMain.runFromConfig
Starting server
[junit4] 2> 1003309 T4821 oasc.ZkTestServer.run start zk server on
port:55591
[junit4] 2> 1003309 T4821
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1003310 T4821 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1003312 T4829 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@b93709 name:ZooKeeperConnection
Watcher:127.0.0.1:55591 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1003312 T4821 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1003312 T4821 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1003313 T4821 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 1003315 T4821
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1003316 T4821 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1003317 T4832 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@521b4 name:ZooKeeperConnection
Watcher:127.0.0.1:55591/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 1003317 T4821 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1003317 T4821 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1003318 T4821 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 1003320 T4821 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 1003321 T4821 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 1003322 T4821 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 1003323 T4821 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 1003323 T4821 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 1003325 T4821 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 1003325 T4821 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 1003327 T4821 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1003327 T4821 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1003328 T4821 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 1003329 T4821 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 1003330 T4821 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 1003330 T4821 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 1003331 T4821 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 1003332 T4821 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 1003333 T4821 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 1003333 T4821 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 1003334 T4821 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 1003335 T4821 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 1003336 T4821 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1003336 T4821 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1003337 T4821 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 1003338 T4821 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 1003339 T4821 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 1003339 T4821 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> 1003572 T4821 oas.SolrTestCaseJ4.writeCoreProperties Writing
core.properties file to
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/control-001/cores/collection1
[junit4] 2> 1003573 T4821 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1003587 T4821 oejs.AbstractConnector.doStart Started
[email protected]:?????
[junit4] 2> 1003588 T4821 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@47034b
[junit4] 2> 1003589 T4821 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 1003589 T4821 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/control-001
[junit4] 2> 1003589 T4821 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/control-001/'
[junit4] 2> 1003601 T4821 oasc.ConfigSolr.fromFile Loading container
configuration from
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/control-001/solr.xml
[junit4] 2> 1003611 T4821 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/control-001/cores
[junit4] 2> 1003612 T4821 oasc.CoreContainer.<init> New CoreContainer
2700576
[junit4] 2> 1003612 T4821 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/control-001/]
[junit4] 2> 1003613 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 1003613 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 1003614 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 1003614 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 1003614 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 1003614 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 1003615 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 1003615 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 1003615 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 1003616 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 1003616 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting useRetries to: false
[junit4] 2> 1003616 T4821 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1003617 T4821 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1003617 T4821 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1003617 T4821 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 1003618 T4821 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:55591/solr
[junit4] 2> 1003618 T4821 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 1003618 T4821
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1003619 T4821 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1003620 T4844 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@7de074 name:ZooKeeperConnection
Watcher:127.0.0.1:55591 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1003621 T4821 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1003622 T4821 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1003623 T4821 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1003624 T4847 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@79c12f name:ZooKeeperConnection
Watcher:127.0.0.1:55591/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 1003625 T4821 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1003626 T4821 oascc.SolrZkClient.makePath makePath:
/overseer/queue
[junit4] 2> 1003627 T4821 oascc.SolrZkClient.makePath makePath:
/overseer/collection-queue-work
[junit4] 2> 1003629 T4821 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-running
[junit4] 2> 1003631 T4821 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-completed
[junit4] 2> 1003632 T4821 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-failure
[junit4] 2> 1003634 T4821 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 1003634 T4821 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:37869_o%2Fke
[junit4] 2> 1003635 T4821 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:37869_o%2Fke
[junit4] 2> 1003636 T4821 oascc.SolrZkClient.makePath makePath:
/overseer_elect
[junit4] 2> 1003638 T4821 oascc.SolrZkClient.makePath makePath:
/overseer_elect/election
[junit4] 2> 1003639 T4821 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 1003640 T4821 oasc.OverseerElectionContext.runLeaderProcess I
am going to be the leader 127.0.0.1:37869_o%2Fke
[junit4] 2> 1003640 T4821 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 1003641 T4821 oasc.Overseer.start Overseer
(id=93239880262352899-127.0.0.1:37869_o%2Fke-n_0000000000) starting
[junit4] 2> 1003643 T4821 oascc.SolrZkClient.makePath makePath:
/overseer/queue-work
[junit4] 2> 1003648 T4821 oasc.OverseerAutoReplicaFailoverThread.<init>
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 1003648 T4849 oasc.OverseerCollectionProcessor.run Process
current queue of collection creations
[junit4] 2> 1003649 T4821 oascc.SolrZkClient.makePath makePath:
/clusterstate.json
[junit4] 2> 1003650 T4821 oascc.SolrZkClient.makePath makePath:
/aliases.json
[junit4] 2> 1003651 T4821
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1003654 T4821 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/control-001/cores
[junit4] 2> 1003655 T4821 oasc.CorePropertiesLocator.discoverUnder Found
core collection1 in
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/control-001/cores/collection1/
[junit4] 2> 1003655 T4821 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 1003656 T4851 oasc.ZkController.publish publishing
core=collection1 state=down collection=control_collection
[junit4] 2> 1003656 T4851 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 1003657 T4851 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 1003657 T4848 oasc.Overseer$ClusterStateUpdater.run Starting
to work on the main queue
[junit4] 2> 1003659 T4848 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 0, message = {
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "numShards":"1",
[junit4] 2> "node_name":"127.0.0.1:37869_o%2Fke",
[junit4] 2> "shard":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "base_url":"http://127.0.0.1:37869/o/ke";,
[junit4] 2> "roles":null} current state version: 0
[junit4] 2> 1003661 T4848 oasco.ReplicaMutator.updateState Update state
numShards=1 message={
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "numShards":"1",
[junit4] 2> "node_name":"127.0.0.1:37869_o%2Fke",
[junit4] 2> "shard":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "base_url":"http://127.0.0.1:37869/o/ke";,
[junit4] 2> "roles":null}
[junit4] 2> 1003662 T4848 oasco.ClusterStateMutator.createCollection
building a new cName: control_collection
[junit4] 2> 1003662 T4848 oasco.ReplicaMutator.updateState Assigning new
node to shard shard=shard1
[junit4] 2> 1003663 T4847 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> 1003665 T4852 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1004657 T4851 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for collection1
[junit4] 2> 1004657 T4851 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:control_collection
[junit4] 2> 1004658 T4851 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 1004658 T4851 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/control_collection
[junit4] 2> 1004659 T4851 oascc.ZkStateReader.readConfigName
path=/collections/control_collection configName=conf1 specified config exists
in ZooKeeper
[junit4] 2> 1004659 T4851 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/control-001/cores/collection1/'
[junit4] 2> 1004672 T4851 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 1004675 T4851 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 1004681 T4851 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 1004696 T4851 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.1.0
[junit4] 2> 1004726 T4851 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 1004727 T4851 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 1004745 T4851 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 1004993 T4851 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1004998 T4851 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 1005000 T4851 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1005009 T4851 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1005012 T4851 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1005023 T4851 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1005024 T4851
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1005024 T4851
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1005024 T4851 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1005025 T4851
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1005025 T4851
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1005026 T4851 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection control_collection
[junit4] 2> 1005026 T4851 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1005026 T4851 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/control-001/cores/collection1/,
dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/tempDir-001/control/data/
[junit4] 2> 1005027 T4851 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1a33da2
[junit4] 2> 1005027 T4851 oasc.CachingDirectoryFactory.get return new
directory for
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/tempDir-001/control/data
[junit4] 2> 1005027 T4851 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/tempDir-001/control/data/index/
[junit4] 2> 1005028 T4851 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/tempDir-001/control/data/index' doesn't exist. Creating
new index...
[junit4] 2> 1005028 T4851 oasc.CachingDirectoryFactory.get return new
directory for
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/tempDir-001/control/data/index
[junit4] 2> 1005028 T4851 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=44, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 1005029 T4851 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@6498bc
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6762f2),segFN=segments_1,generation=1}
[junit4] 2> 1005030 T4851 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 1005032 T4851 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 1005033 T4851 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 1005033 T4851 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1005033 T4851 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 1005033 T4851 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1005034 T4851 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1005034 T4851 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1005034 T4851 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 1005035 T4851 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1005035 T4851 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1005035 T4851 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1005036 T4851 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1005036 T4851 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1005037 T4851 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 1005037 T4851 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 1005037 T4851 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 1005038 T4851 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 1005038 T4851 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 1005039 T4851 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 1005039 T4851 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 1005040 T4851 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 1005040 T4851 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 1005040 T4851 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 1005041 T4851 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 1005041 T4851 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 1005041 T4851 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 1005041 T4851 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 1005044 T4851 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1005045 T4851 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1005046 T4851 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1005047 T4851 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1005048 T4851 oasc.SolrCore.initStatsCache Using default
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1005049 T4851 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 1005049 T4851 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 1005050 T4851 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=11,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1005050 T4851 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@6498bc
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6762f2),segFN=segments_1,generation=1}
[junit4] 2> 1005050 T4851 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 1005050 T4851 oass.SolrIndexSearcher.<init> Opening
Searcher@9ffe20[collection1] main
[junit4] 2> 1005051 T4851 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/control_collection
[junit4] 2> 1005052 T4851 oascc.ZkStateReader.readConfigName
path=/collections/control_collection configName=conf1 specified config exists
in ZooKeeper
[junit4] 2> 1005052 T4851 oasr.ManagedResourceStorage.newStorageIO Setting
up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 1005052 T4851
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 1005052 T4851 oasr.RestManager.init Initializing RestManager
with initArgs: {}
[junit4] 2> 1005053 T4851 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1005053 T4851
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 1005053 T4851 oasr.ManagedResourceStorage.load Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1005053 T4851 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 1005054 T4851 oash.ReplicationHandler.inform Commits will be
reserved for 10000
[junit4] 2> 1005054 T4853 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@9ffe20[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1005054 T4851 oasc.CoreContainer.registerCore registering
core: collection1
[junit4] 2> 1005055 T4856 oasc.ZkController.register Register replica -
core:collection1 address:http://127.0.0.1:37869/o/ke
collection:control_collection shard:shard1
[junit4] 2> 1005055 T4821 oass.SolrDispatchFilter.init
user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1
[junit4] 2> 1005056 T4821 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 1005056 T4856 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/leader_elect/shard1/election
[junit4] 2> 1005056 T4821
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1005057 T4821 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1005058 T4859 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1cb1ae5 name:ZooKeeperConnection
Watcher:127.0.0.1:55591/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 1005058 T4821 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1005059 T4821 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1005059 T4821
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1005060 T4856 oasc.ShardLeaderElectionContext.runLeaderProcess
Running the leader process for shard shard1
[junit4] 2> 1005061 T4847 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1005061 T4856
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 1005061 T4856 oasc.ShardLeaderElectionContext.runLeaderProcess
I may be the new leader - try and sync
[junit4] 2> ASYNC NEW_CORE C2465 name=collection1
org.apache.solr.core.SolrCore@caa1a7
url=http://127.0.0.1:37869/o/ke/collection1 node=127.0.0.1:37869_o%2Fke
C2465_STATE=coll:control_collection core:collection1 props:{state=down,
node_name=127.0.0.1:37869_o%2Fke, core=collection1,
base_url=http://127.0.0.1:37869/o/ke}
[junit4] 2> 1005062 T4856 C2465 P37869 oasc.SyncStrategy.sync Sync
replicas to http://127.0.0.1:37869/o/ke/collection1/
[junit4] 2> 1005062 T4848 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection"} current state
version: 1
[junit4] 2> 1005062 T4856 C2465 P37869 oasc.SyncStrategy.syncReplicas Sync
Success - now sync replicas to me
[junit4] 2> 1005062 T4856 C2465 P37869 oasc.SyncStrategy.syncToMe
http://127.0.0.1:37869/o/ke/collection1/ has no replicas
[junit4] 2> 1005062 T4856 oasc.ShardLeaderElectionContext.runLeaderProcess
I am the new leader: http://127.0.0.1:37869/o/ke/collection1/ shard1
[junit4] 2> 1005063 T4856 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/leaders/shard1
[junit4] 2> 1005064 T4821 oasc.ChaosMonkey.monkeyLog monkey: init - expire
sessions:false cause connection loss:false
[junit4] 2> 1005064 T4821 oasc.AbstractFullDistribZkTestBase.createJettys
Creating collection1 with stateFormat=2
[junit4] 2> 1005064 T4821
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1005065 T4821 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1005065 T4847 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1005066 T4862 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@15dee9b name:ZooKeeperConnection
Watcher:127.0.0.1:55591/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 1005066 T4848 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "base_url":"http://127.0.0.1:37869/o/ke";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 1
[junit4] 2> 1005066 T4821 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1005067 T4821 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1005068 T4847 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1005069 T4848 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"create",
[junit4] 2> "name":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "stateFormat":"2"} current state version: 1
[junit4] 2> 1005069 T4848 oasco.ClusterStateMutator.createCollection
building a new cName: collection1
[junit4] 2> 1005069 T4847 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> 1005069 T4859 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> 1005173 T4848 oasco.ZkStateWriter.writePendingUpdates going to
create_collection /collections/collection1/state.json
[junit4] 2> 1005174 T4859 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> 1005217 T4856 oasc.ZkController.register We are
http://127.0.0.1:37869/o/ke/collection1/ and leader is
http://127.0.0.1:37869/o/ke/collection1/
[junit4] 2> 1005217 T4856 oasc.ZkController.register No LogReplay needed
for core=collection1 baseURL=http://127.0.0.1:37869/o/ke
[junit4] 2> 1005217 T4856 oasc.ZkController.checkRecovery I am the leader,
no recovery necessary
[junit4] 2> 1005217 T4856 oasc.ZkController.publish publishing
core=collection1 state=active collection=control_collection
[junit4] 2> 1005218 T4856 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 1005219 T4847 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1005220 T4848 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "state":"active",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:37869_o%2Fke",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"collection1",
[junit4] 2> "base_url":"http://127.0.0.1:37869/o/ke";,
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null} current state version: 3
[junit4] 2> 1005220 T4848 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "state":"active",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:37869_o%2Fke",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"collection1",
[junit4] 2> "base_url":"http://127.0.0.1:37869/o/ke";,
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null}
[junit4] 2> 1005299 T4821 oas.SolrTestCaseJ4.writeCoreProperties Writing
core.properties file to
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-1-001/cores/collection1
[junit4] 2> 1005300 T4821 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1
[junit4] 2> 1005301 T4821 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1005303 T4821 oejs.AbstractConnector.doStart Started
[email protected]:?????
[junit4] 2> 1005304 T4821 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@47034b
[junit4] 2> 1005304 T4821 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 1005304 T4821 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-1-001
[junit4] 2> 1005304 T4821 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-1-001/'
[junit4] 2> 1005316 T4821 oasc.ConfigSolr.fromFile Loading container
configuration from
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-1-001/solr.xml
[junit4] 2> 1005323 T4859 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> 1005323 T4847 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> 1005327 T4821 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-1-001/cores
[junit4] 2> 1005327 T4821 oasc.CoreContainer.<init> New CoreContainer
7496349
[junit4] 2> 1005327 T4821 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-1-001/]
[junit4] 2> 1005328 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 1005328 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 1005328 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 1005329 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 1005329 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 1005329 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 1005329 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 1005330 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 1005330 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 1005330 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 1005330 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting useRetries to: false
[junit4] 2> 1005331 T4821 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1005331 T4821 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1005331 T4821 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1005332 T4821 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 1005332 T4821 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:55591/solr
[junit4] 2> 1005332 T4821 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 1005333 T4821
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1005333 T4821 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1005334 T4874 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@f76715 name:ZooKeeperConnection
Watcher:127.0.0.1:55591 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1005335 T4821 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1005335 T4821 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1005337 T4821 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1005338 T4877 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1de89e1 name:ZooKeeperConnection
Watcher:127.0.0.1:55591/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 1005338 T4821 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1005342 T4821
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1006345 T4821 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34221_o%2Fke
[junit4] 2> 1006346 T4821 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:34221_o%2Fke
[junit4] 2> 1006349 T4821 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 1006351 T4821 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-1-001/cores
[junit4] 2> 1006352 T4821 oasc.CorePropertiesLocator.discoverUnder Found
core collection1 in
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-1-001/cores/collection1/
[junit4] 2> 1006352 T4821 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 1006354 T4878 oasc.ZkController.publish publishing
core=collection1 state=down collection=collection1
[junit4] 2> 1006354 T4878 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 1006356 T4878 oasc.ZkController.preRegister Registering watch
for external collection collection1
[junit4] 2> 1006357 T4878 oascc.ZkStateReader.addZkWatch addZkWatch
collection1
[junit4] 2> 1006357 T4847 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1006357 T4878 oascc.ZkStateReader.addZkWatch Updating
collection state at /collections/collection1/state.json from ZooKeeper...
[junit4] 2> 1006358 T4848 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:34221_o%2Fke",
[junit4] 2> "shard":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "base_url":"http://127.0.0.1:34221/o/ke";,
[junit4] 2> "roles":null} current state version: 4
[junit4] 2> 1006358 T4878 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 0
[junit4] 2> 1006358 T4848 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:34221_o%2Fke",
[junit4] 2> "shard":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "base_url":"http://127.0.0.1:34221/o/ke";,
[junit4] 2> "roles":null}
[junit4] 2> 1006358 T4878 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 1006358 T4848 oasco.ReplicaMutator.updateState Collection
already exists with numShards=2
[junit4] 2> 1006359 T4848 oasco.ReplicaMutator.updateState Assigning new
node to shard shard=shard1
[junit4] 2> 1006461 T4848 oasco.ZkStateWriter.writePendingUpdates going to
update_collection /collections/collection1/state.json version: 0
[junit4] 2> 1006462 T4877 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 1006462 T4877 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 1
[junit4] 2> 1007359 T4878 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for collection1
[junit4] 2> 1007359 T4878 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:collection1
[junit4] 2> 1007360 T4878 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 1007360 T4878 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 1007362 T4878 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 1007362 T4878 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-1-001/cores/collection1/'
[junit4] 2> 1007374 T4878 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 1007376 T4878 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 1007382 T4878 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 1007393 T4878 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.1.0
[junit4] 2> 1007428 T4878 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 1007429 T4878 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 1007435 T4878 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 1007639 T4878 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1007643 T4878 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 1007645 T4878 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1007652 T4878 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1007655 T4878 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1007657 T4878 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1007657 T4878
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1007658 T4878
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1007658 T4878 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1007659 T4878
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1007659 T4878
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1007659 T4878 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection collection1
[junit4] 2> 1007659 T4878 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1007659 T4878 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-1-001/cores/collection1/,
dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/tempDir-001/jetty1/
[junit4] 2> 1007660 T4878 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1a33da2
[junit4] 2> 1007660 T4878 oasc.CachingDirectoryFactory.get return new
directory for
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/tempDir-001/jetty1
[junit4] 2> 1007660 T4878 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/tempDir-001/jetty1/index/
[junit4] 2> 1007661 T4878 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/tempDir-001/jetty1/index' doesn't exist. Creating new
index...
[junit4] 2> 1007661 T4878 oasc.CachingDirectoryFactory.get return new
directory for
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/tempDir-001/jetty1/index
[junit4] 2> 1007661 T4878 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=44, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 1007662 T4878 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1cc6a6
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@135dd2c),segFN=segments_1,generation=1}
[junit4] 2> 1007662 T4878 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 1007664 T4878 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 1007665 T4878 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 1007665 T4878 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1007665 T4878 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 1007665 T4878 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1007665 T4878 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1007666 T4878 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1007666 T4878 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 1007666 T4878 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1007666 T4878 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1007667 T4878 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1007667 T4878 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1007667 T4878 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1007668 T4878 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 1007668 T4878 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 1007669 T4878 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 1007669 T4878 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 1007669 T4878 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 1007670 T4878 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 1007670 T4878 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 1007670 T4878 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 1007671 T4878 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 1007671 T4878 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 1007671 T4878 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 1007672 T4878 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 1007672 T4878 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 1007673 T4878 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 1007675 T4878 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1007676 T4878 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1007676 T4878 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1007677 T4878 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1007678 T4878 oasc.SolrCore.initStatsCache Using default
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1007679 T4878 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 1007679 T4878 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 1007680 T4878 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=11,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1007680 T4878 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1cc6a6
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@135dd2c),segFN=segments_1,generation=1}
[junit4] 2> 1007680 T4878 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 1007681 T4878 oass.SolrIndexSearcher.<init> Opening
Searcher@1c49c2a[collection1] main
[junit4] 2> 1007681 T4878 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 1007682 T4878 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 1007682 T4878 oasr.ManagedResourceStorage.newStorageIO Setting
up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 1007682 T4878
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 1007682 T4878 oasr.RestManager.init Initializing RestManager
with initArgs: {}
[junit4] 2> 1007682 T4878 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1007683 T4878
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 1007683 T4878 oasr.ManagedResourceStorage.load Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1007683 T4878 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 1007683 T4878 oash.ReplicationHandler.inform Commits will be
reserved for 10000
[junit4] 2> 1007684 T4879 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@1c49c2a[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1007684 T4878 oasc.CoreContainer.registerCore registering
core: collection1
[junit4] 2> 1007685 T4882 oasc.ZkController.register Register replica -
core:collection1 address:http://127.0.0.1:34221/o/ke collection:collection1
shard:shard1
[junit4] 2> 1007685 T4821 oass.SolrDispatchFilter.init
user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1
[junit4] 2> 1007686 T4821 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 1007686 T4882 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leader_elect/shard1/election
[junit4] 2> 1007689 T4882 oasc.ShardLeaderElectionContext.runLeaderProcess
Running the leader process for shard shard1
[junit4] 2> 1007690 T4847 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1007690 T4882
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 1007691 T4882 oasc.ShardLeaderElectionContext.runLeaderProcess
I may be the new leader - try and sync
[junit4] 2> ASYNC NEW_CORE C2466 name=collection1
org.apache.solr.core.SolrCore@c4fbc1
url=http://127.0.0.1:34221/o/ke/collection1 node=127.0.0.1:34221_o%2Fke
C2466_STATE=coll:collection1 core:collection1 props:{state=down,
node_name=127.0.0.1:34221_o%2Fke, core=collection1,
base_url=http://127.0.0.1:34221/o/ke}
[junit4] 2> 1007691 T4882 C2466 P34221 oasc.SyncStrategy.sync Sync
replicas to http://127.0.0.1:34221/o/ke/collection1/
[junit4] 2> 1007691 T4848 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"collection1"} current state version: 4
[junit4] 2> 1007691 T4882 C2466 P34221 oasc.SyncStrategy.syncReplicas Sync
Success - now sync replicas to me
[junit4] 2> 1007691 T4882 C2466 P34221 oasc.SyncStrategy.syncToMe
http://127.0.0.1:34221/o/ke/collection1/ has no replicas
[junit4] 2> 1007692 T4882 oasc.ShardLeaderElectionContext.runLeaderProcess
I am the new leader: http://127.0.0.1:34221/o/ke/collection1/ shard1
[junit4] 2> 1007692 T4882 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leaders/shard1
[junit4] 2> 1007692 T4848 oasco.ZkStateWriter.writePendingUpdates going to
update_collection /collections/collection1/state.json version: 1
[junit4] 2> 1007692 T4877 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 1007693 T4877 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 2
[junit4] 2> 1007695 T4847 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1007696 T4848 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "base_url":"http://127.0.0.1:34221/o/ke";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 4
[junit4] 2> 1007697 T4848 oasco.ZkStateWriter.writePendingUpdates going to
update_collection /collections/collection1/state.json version: 2
[junit4] 2> 1007697 T4877 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 1007698 T4877 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 3
[junit4] 2> 1007746 T4882 oasc.ZkController.register We are
http://127.0.0.1:34221/o/ke/collection1/ and leader is
http://127.0.0.1:34221/o/ke/collection1/
[junit4] 2> 1007746 T4882 oasc.ZkController.register No LogReplay needed
for core=collection1 baseURL=http://127.0.0.1:34221/o/ke
[junit4] 2> 1007746 T4882 oasc.ZkController.checkRecovery I am the leader,
no recovery necessary
[junit4] 2> 1007746 T4882 oasc.ZkController.publish publishing
core=collection1 state=active collection=collection1
[junit4] 2> 1007746 T4882 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 1007747 T4847 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1007748 T4848 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "state":"active",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:34221_o%2Fke",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"collection1",
[junit4] 2> "base_url":"http://127.0.0.1:34221/o/ke";,
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null} current state version: 4
[junit4] 2> 1007749 T4848 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "state":"active",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:34221_o%2Fke",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"collection1",
[junit4] 2> "base_url":"http://127.0.0.1:34221/o/ke";,
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null}
[junit4] 2> 1007750 T4882 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 3
[junit4] 2> 1007750 T4848 oasco.ZkStateWriter.writePendingUpdates going to
update_collection /collections/collection1/state.json version: 3
[junit4] 2> 1007750 T4877 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 1007751 T4877 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 4
[junit4] 2> 1007923 T4821 oas.SolrTestCaseJ4.writeCoreProperties Writing
core.properties file to
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-2-001/cores/collection1
[junit4] 2> 1007924 T4821 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2
[junit4] 2> 1007925 T4821 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1007926 T4821 oejs.AbstractConnector.doStart Started
[email protected]:?????
[junit4] 2> 1007927 T4821 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@47034b
[junit4] 2> 1007928 T4821 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 1007928 T4821 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-2-001
[junit4] 2> 1007928 T4821 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-2-001/'
[junit4] 2> 1007940 T4821 oasc.ConfigSolr.fromFile Loading container
configuration from
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-2-001/solr.xml
[junit4] 2> 1007950 T4821 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-2-001/cores
[junit4] 2> 1007951 T4821 oasc.CoreContainer.<init> New CoreContainer
16136275
[junit4] 2> 1007951 T4821 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-2-001/]
[junit4] 2> 1007951 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 1007952 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 1007952 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 1007952 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 1007953 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 1007953 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 1007953 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 1007953 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 1007954 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 1007954 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 1007954 T4821 oashc.HttpShardHandlerFactory.getParameter
Setting useRetries to: false
[junit4] 2> 1007954 T4821 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1007955 T4821 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1007955 T4821 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1007955 T4821 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 1007956 T4821 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:55591/solr
[junit4] 2> 1007956 T4821 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 1007956 T4821
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1007957 T4821 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1007958 T4894 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@420fe3 name:ZooKeeperConnection
Watcher:127.0.0.1:55591 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1007959 T4821 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1007960 T4821 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1007961 T4821 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1007962 T4897 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@c7bb53 name:ZooKeeperConnection
Watcher:127.0.0.1:55591/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 1007963 T4821 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1007967 T4821
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1008971 T4821 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:55107_o%2Fke
[junit4] 2> 1008973 T4821 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:55107_o%2Fke
[junit4] 2> 1008980 T4821 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 1008984 T4821 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-2-001/cores
[junit4] 2> 1008984 T4821 oasc.CorePropertiesLocator.discoverUnder Found
core collection1 in
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-2-001/cores/collection1/
[junit4] 2> 1008985 T4821 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 1008989 T4898 oasc.ZkController.publish publishing
core=collection1 state=down collection=collection1
[junit4] 2> 1008989 T4898 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 1008990 T4847 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1008990 T4898 oasc.ZkController.preRegister Registering watch
for external collection collection1
[junit4] 2> 1008991 T4898 oascc.ZkStateReader.addZkWatch addZkWatch
collection1
[junit4] 2> 1008991 T4848 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:55107_o%2Fke",
[junit4] 2> "shard":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "base_url":"http://127.0.0.1:55107/o/ke";,
[junit4] 2> "roles":null} current state version: 4
[junit4] 2> 1008991 T4898 oascc.ZkStateReader.addZkWatch Updating
collection state at /collections/collection1/state.json from ZooKeeper...
[junit4] 2> 1008991 T4848 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "state":"down",
[junit4] 2> "operation":"state",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:55107_o%2Fke",
[junit4] 2> "shard":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "base_url":"http://127.0.0.1:55107/o/ke";,
[junit4] 2> "roles":null}
[junit4] 2> 1008991 T4848 oasco.ReplicaMutator.updateState Collection
already exists with numShards=2
[junit4] 2> 1008992 T4848 oasco.ReplicaMutator.updateState Assigning new
node to shard shard=shard2
[junit4] 2> 1008992 T4898 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 4
[junit4] 2> 1009007 T4898 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 1009009 T4848 oasco.ZkStateWriter.writePendingUpdates going to
update_collection /collections/collection1/state.json version: 4
[junit4] 2> 1009010 T4897 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 1009010 T4877 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 1009010 T4897 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 5
[junit4] 2> 1009011 T4877 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 5
[junit4] 2> 1010008 T4898 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for collection1
[junit4] 2> 1010008 T4898 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:collection1
[junit4] 2> 1010009 T4898 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 1010009 T4898 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 1010010 T4898 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 1010010 T4898 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-2-001/cores/collection1/'
[junit4] 2> 1010020 T4898 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 1010022 T4898 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 1010027 T4898 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 1010037 T4898 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.1.0
[junit4] 2> 1010060 T4898 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 1010061 T4898 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 1010066 T4898 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 1010272 T4898 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1010276 T4898 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 1010277 T4898 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1010285 T4898 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1010288 T4898 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1010290 T4898 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1010290 T4898
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1010291 T4898
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1010291 T4898 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1010292 T4898
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1010292 T4898
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1010292 T4898 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection collection1
[junit4] 2> 1010292 T4898 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1010292 T4898 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-2-001/cores/collection1/,
dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/tempDir-001/jetty2/
[junit4] 2> 1010293 T4898 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1a33da2
[junit4] 2> 1010293 T4898 oasc.CachingDirectoryFactory.get return new
directory for
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/tempDir-001/jetty2
[junit4] 2> 1010293 T4898 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/tempDir-001/jetty2/index/
[junit4] 2> 1010293 T4898 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/tempDir-001/jetty2/index' doesn't exist. Creating new
index...
[junit4] 2> 1010294 T4898 oasc.CachingDirectoryFactory.get return new
directory for
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/tempDir-001/jetty2/index
[junit4] 2> 1010294 T4898 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=44, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 1010295 T4898 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@75cb04
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@163a722),segFN=segments_1,generation=1}
[junit4] 2> 1010295 T4898 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 1010297 T4898 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 1010298 T4898 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 1010298 T4898 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1010298 T4898 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 1010298 T4898 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1010298 T4898 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1010299 T4898 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1010299 T4898 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 1010299 T4898 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1010299 T4898 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1010300 T4898 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1010300 T4898 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1010300 T4898 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1010301 T4898 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 1010301 T4898 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 1010301 T4898 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 1010302 T4898 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 1010302 T4898 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 1010303 T4898 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 1010303 T4898 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 1010303 T4898 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 1010304 T4898 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 1010304 T4898 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 1010304 T4898 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 1010305 T4898 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 1010305 T4898 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 1010305 T4898 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 1010308 T4898 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1010309 T4898 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1010309 T4898 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1010310 T4898 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1010311 T4898 oasc.SolrCore.initStatsCache Using default
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1010312 T4898 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 1010312 T4898 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 1010313 T4898 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=11,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1010313 T4898 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@75cb04
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@163a722),segFN=segments_1,generation=1}
[junit4] 2> 1010313 T4898 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 1010313 T4898 oass.SolrIndexSearcher.<init> Opening
Searcher@25c088[collection1] main
[junit4] 2> 1010314 T4898 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 1010314 T4898 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 1010314 T4898 oasr.ManagedResourceStorage.newStorageIO Setting
up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 1010315 T4898
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 1010315 T4898 oasr.RestManager.init Initializing RestManager
with initArgs: {}
[junit4] 2> 1010315 T4898 o
[...truncated too long message...]
[junit4] 2> 1027815 T4821 oasc.SolrCore.close [.system_shard1_replica2]
CLOSING SolrCore org.apache.solr.core.SolrCore@169d7c8
[junit4] 2> 1027815 T4821 oasc.ZkController.unRegisterConfListener a
listener was removed because of core close
[junit4] 2> 1027815 T4821 oasu.DirectUpdateHandler2.close closing
DirectUpdateHandler2{commits=3,autocommit maxDocs=1,autocommits=1,soft
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=2,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=3477,transaction_logs_total_number=2}
[junit4] 2> 1027816 T4821 oasu.SolrCoreState.decrefSolrCoreState Closing
SolrCoreState
[junit4] 2> 1027816 T4821 oasu.DefaultSolrCoreState.closeIndexWriter
SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 1027816 T4821 oasu.DefaultSolrCoreState.closeIndexWriter
closing IndexWriter with IndexWriterCloser
[junit4] 2> 1027817 T4821 oasc.SolrCore.closeSearcher
[.system_shard1_replica2] Closing main searcher on request.
[junit4] 2> 1027817 T4821 oasc.CachingDirectoryFactory.close Closing
MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 1027818 T4821 oasc.CachingDirectoryFactory.closeCacheValue
looking to close
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-4-001/cores/.system_shard1_replica2/data/index
[CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-4-001/cores/.system_shard1_replica2/data/index;done=false>>]
[junit4] 2> 1027818 T4821 oasc.CachingDirectoryFactory.close Closing
directory:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-4-001/cores/.system_shard1_replica2/data/index
[junit4] 2> 1027818 T4821 oasc.CachingDirectoryFactory.closeCacheValue
looking to close
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-4-001/cores/.system_shard1_replica2/data
[CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-4-001/cores/.system_shard1_replica2/data;done=false>>]
[junit4] 2> 1027818 T4821 oasc.CachingDirectoryFactory.close Closing
directory:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001/shard-4-001/cores/.system_shard1_replica2/data
[junit4] 2> 1027819 T4821 oasc.Overseer.close Overseer
(id=93239880262352909-127.0.0.1:48408_o%2Fke-n_0000000004) closing
[junit4] 2> 1027820 T4985 oasc.Overseer$ClusterStateUpdater.run Overseer
Loop exiting : 127.0.0.1:48408_o%2Fke
[junit4] 2> 1029320 T4939 oascc.ZkStateReader$7.process WARN ZooKeeper
watch triggered, but Solr cannot talk to ZK
[junit4] 2> 1029320 T4984 oascc.ZkStateReader$3.process WARN ZooKeeper
watch triggered, but Solr cannot talk to ZK
[junit4] 2> 1029320 T4979 oascc.ZkStateReader$7.process WARN ZooKeeper
watch triggered, but Solr cannot talk to ZK
[junit4] 2> 1029344 T4821 oejsh.ContextHandler.doStop stopped
o.e.j.s.ServletContextHandler{/o/ke,null}
[junit4] 2> 1029534 T4821 oasc.ZkTestServer.send4LetterWord connecting to
127.0.0.1:55591 55591
[junit4] 2> 1030214 T4822 oasc.ZkTestServer.send4LetterWord connecting to
127.0.0.1:55591 55591
[junit4] 2> 1030215 T4822 oasc.ZkTestServer$ZKServerMain.runFromConfig
WARN Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 6 /solr/clusterstate.json
[junit4] 2> 6 /solr/aliases.json
[junit4] 2> 5 /solr/configs/conf1
[junit4] 2> 4 /solr/collections/collection1/state.json
[junit4] 2> 2 /solr/configs/.system
[junit4] 2> 2 /solr/collections/.system/state.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/overseer/queue
[junit4] 2>
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestBlobHandler
-Dtests.method=doBlobHandlerTest -Dtests.seed=4A617A95729D091C
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=th_TH_TH_#u-nu-thai
-Dtests.timezone=America/Mexico_City -Dtests.asserts=true
-Dtests.file.encoding=US-ASCII
[junit4] FAILURE 27.0s J1 | TestBlobHandler.doBlobHandlerTest <<<
[junit4] > Throwable #1: java.lang.AssertionError:
{responseHeader={status=0, QTime=1}, response={numFound=0, start=0, docs=[]}}
[junit4] > at
__randomizedtesting.SeedInfo.seed([4A617A95729D091C:AAA058C7C9717FEE]:0)
[junit4] > at
org.apache.solr.handler.TestBlobHandler.doBlobHandlerTest(TestBlobHandler.java:96)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:940)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:915)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 1030222 T4821 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.TestBlobHandler
4A617A95729D091C-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50):
{version=PostingsFormat(name=Memory doPackFST= true),
blobName=PostingsFormat(name=Memory doPackFST= true),
_version_=Lucene50(blocksize=128), timestamp=Lucene50(blocksize=128),
id=PostingsFormat(name=LuceneVarGapFixedInterval), md5=Lucene50(blocksize=128),
size=Lucene50(blocksize=128)}, docValues:{},
sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {},
locale=th_TH_TH_#u-nu-thai, timezone=America/Mexico_City
[junit4] 2> NOTE: Linux 3.13.0-44-generic i386/Oracle Corporation
1.7.0_80-ea (32-bit)/cpus=8,threads=1,free=73722944,total=199782400
[junit4] 2> NOTE: All tests run in this JVM: [BasicDistributedZk2Test,
TestRequestStatusCollectionAPI, ExternalCollectionsTest, StatsComponentTest,
SpellCheckCollatorTest, TestValueSourceCache, EnumFieldTest,
DistributedTermsComponentTest, DocValuesMissingTest,
TestPHPSerializedResponseWriter, OpenCloseCoreStressTest,
IgnoreCommitOptimizeUpdateProcessorFactoryTest, InfoHandlerTest,
AsyncMigrateRouteKeyTest, RecoveryAfterSoftCommitTest,
HighlighterMaxOffsetTest, TestInitQParser, HdfsWriteToMultipleCollectionsTest,
TestZkChroot, LoggingHandlerTest, TestDynamicFieldCollectionResource,
HighlighterTest, SolrRequestParserTest, HttpPartitionTest, TestUtils,
TestRandomMergePolicy, ConvertedLegacyTest, TestConfigOverlay,
TestCloudInspectUtil, PrimitiveFieldTypeTest,
SchemaVersionSpecificBehaviorTest, TestOrdValues, TestRTGBase, ShardSplitTest,
TestConfigReload, DisMaxRequestHandlerTest, FastVectorHighlighterTest,
CursorPagingTest, TestDynamicFieldResource, HighlighterConfigTest,
RegexBoostProcessorTest, CursorMarkTest, SolrXmlInZkTest,
TestLeaderElectionZkExpiry, TestStandardQParsers,
SharedFSAutoReplicaFailoverUtilsTest, TestExceedMaxTermLength,
DebugComponentTest, OverseerCollectionProcessorTest, TestFieldResource,
TestFieldSortValues, ZkNodePropsTest, SpellingQueryConverterTest,
ReturnFieldsTest, TestExactStatsCache, TestFastOutputStream, TestRangeQuery,
LeaderInitiatedRecoveryOnCommitTest, TestDistributedMissingSort,
TestRestManager, StandardRequestHandlerTest, TestRealTimeGet,
TestSolrDeletionPolicy2, TestPseudoReturnFields, TestDFRSimilarityFactory,
TestLuceneMatchVersion, TestDistributedGrouping, IndexSchemaTest,
TestImplicitCoreProperties, DocExpirationUpdateProcessorFactoryTest,
TestDefaultSearchFieldResource, TermVectorComponentTest, JsonLoaderTest,
TestDocBasedVersionConstraints, TestSolrConfigHandlerCloud, FileUtilsTest,
SpellPossibilityIteratorTest, UpdateParamsTest, TestSolrCoreProperties,
CollectionsAPIDistributedZkTest, TestDefaultSimilarityFactory,
ReplicationFactorTest, TestRandomFaceting, TestSolrXml,
OverriddenZkACLAndCredentialsProvidersTest, TestBlobHandler]
[junit4] Completed on J1 in 27.04s, 1 test, 1 failure <<< FAILURES!
[...truncated 860 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:529: The following
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:477: The following
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:61: The following
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/extra-targets.xml:39: The
following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build.xml:191: The
following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/common-build.xml:508: The
following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:1363:
The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:970:
There were test failures: 461 suites, 1847 tests, 1 failure, 46 ignored (21
assumptions)
Total time: 67 minutes 35 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 32bit/jdk1.7.0_80-ea-b05 -server
-XX:+UseSerialGC
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]
