Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Linux/11567/
Java: 64bit/jdk1.7.0_76 -XX:+UseCompressedOops -XX:+UseSerialGC
1 tests failed.
FAILED: org.apache.solr.handler.TestBlobHandler.doBlobHandlerTest
Error Message:
{responseHeader={status=0, QTime=0}, response={numFound=0, start=0, docs=[]}}
Stack Trace:
java.lang.AssertionError: {responseHeader={status=0, QTime=0},
response={numFound=0, start=0, docs=[]}}
at
__randomizedtesting.SeedInfo.seed([FDE5A6ADAAFD4703:1D2484FF111131F1]: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 10342 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
FDE5A6ADAAFD4703-001/init-core-data-001
[junit4] 2> 1951886 T9375 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(false) and clientAuth (true)
[junit4] 2> 1951886 T9375
oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system
property: /
[junit4] 2> 1951890 T9375 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1951890 T9376 oasc.ZkTestServer$ZKServerMain.runFromConfig
Starting server
[junit4] 2> 1951990 T9375 oasc.ZkTestServer.run start zk server on
port:36849
[junit4] 2> 1951991 T9375
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1951991 T9375 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1951999 T9383 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@7c5e589f
name:ZooKeeperConnection Watcher:127.0.0.1:36849 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1951999 T9375 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1952000 T9375 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1952000 T9375 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 1952003 T9375
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1952004 T9375 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1952005 T9386 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1968844c
name:ZooKeeperConnection Watcher:127.0.0.1:36849/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1952005 T9375 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1952005 T9375 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1952006 T9375 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 1952007 T9375 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 1952008 T9375 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 1952010 T9375 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 1952011 T9375 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> 1952011 T9375 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 1952013 T9375 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> 1952014 T9375 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 1952015 T9375 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> 1952016 T9375 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1952017 T9375 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> 1952018 T9375 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 1952019 T9375 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> 1952020 T9375 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 1952021 T9375 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> 1952022 T9375 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 1952023 T9375 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> 1952023 T9375 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 1952025 T9375 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> 1952025 T9375 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 1952026 T9375 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> 1952027 T9375 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1952028 T9375 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> 1952028 T9375 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 1952030 T9375 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> 1952030 T9375 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> 1952267 T9375 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
FDE5A6ADAAFD4703-001/control-001/cores/collection1
[junit4] 2> 1952269 T9375 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1952273 T9375 oejs.AbstractConnector.doStart Started
[email protected]:๔๔๒๘๑
[junit4] 2> 1952274 T9375 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@5472fe25
[junit4] 2> 1952274 T9375 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 1952274 T9375 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
FDE5A6ADAAFD4703-001/control-001
[junit4] 2> 1952274 T9375 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
FDE5A6ADAAFD4703-001/control-001/'
[junit4] 2> 1952286 T9375 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
FDE5A6ADAAFD4703-001/control-001/solr.xml
[junit4] 2> 1952297 T9375 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
FDE5A6ADAAFD4703-001/control-001/cores
[junit4] 2> 1952298 T9375 oasc.CoreContainer.<init> New CoreContainer
1719817553
[junit4] 2> 1952298 T9375 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
FDE5A6ADAAFD4703-001/control-001/]
[junit4] 2> 1952298 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 1952298 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 1952299 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 1952299 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 1952299 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 1952299 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 1952299 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 1952300 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 1952300 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 1952300 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 1952300 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting useRetries to: false
[junit4] 2> 1952300 T9375 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1952301 T9375 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1952301 T9375 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1952301 T9375 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 1952301 T9375 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:36849/solr
[junit4] 2> 1952302 T9375 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 1952302 T9375
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1952302 T9375 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1952304 T9398 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@3d50bd5c
name:ZooKeeperConnection Watcher:127.0.0.1:36849 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1952304 T9375 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1952304 T9375 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1952305 T9375 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1952306 T9401 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@4ad778ac
name:ZooKeeperConnection Watcher:127.0.0.1:36849/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1952307 T9375 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1952308 T9375 oascc.SolrZkClient.makePath makePath:
/overseer/queue
[junit4] 2> 1952309 T9375 oascc.SolrZkClient.makePath makePath:
/overseer/collection-queue-work
[junit4] 2> 1952311 T9375 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-running
[junit4] 2> 1952312 T9375 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-completed
[junit4] 2> 1952314 T9375 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-failure
[junit4] 2> 1952316 T9375 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 1952317 T9375 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:44281_
[junit4] 2> 1952317 T9375 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:44281_
[junit4] 2> 1952319 T9375 oascc.SolrZkClient.makePath makePath:
/overseer_elect
[junit4] 2> 1952320 T9375 oascc.SolrZkClient.makePath makePath:
/overseer_elect/election
[junit4] 2> 1952321 T9375 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 1952322 T9375 oasc.OverseerElectionContext.runLeaderProcess I
am going to be the leader 127.0.0.1:44281_
[junit4] 2> 1952322 T9375 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 1952323 T9375 oasc.Overseer.start Overseer
(id=93246335553241091-127.0.0.1:44281_-n_0000000000) starting
[junit4] 2> 1952324 T9375 oascc.SolrZkClient.makePath makePath:
/overseer/queue-work
[junit4] 2> 1952328 T9375 oasc.OverseerAutoReplicaFailoverThread.<init>
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 1952329 T9403 oasc.OverseerCollectionProcessor.run Process
current queue of collection creations
[junit4] 2> 1952329 T9375 oascc.SolrZkClient.makePath makePath:
/clusterstate.json
[junit4] 2> 1952331 T9375 oascc.SolrZkClient.makePath makePath:
/aliases.json
[junit4] 2> 1952332 T9375
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1952334 T9402 oasc.Overseer$ClusterStateUpdater.run Starting
to work on the main queue
[junit4] 2> 1952335 T9375 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
FDE5A6ADAAFD4703-001/control-001/cores
[junit4] 2> 1952336 T9375 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
FDE5A6ADAAFD4703-001/control-001/cores/collection1/
[junit4] 2> 1952337 T9375 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 1952337 T9405 oasc.ZkController.publish publishing
core=collection1 state=down collection=control_collection
[junit4] 2> 1952338 T9405 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 1952338 T9401 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1952338 T9405 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 1952340 T9402 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 0, message = {
[junit4] 2> "collection":"control_collection",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:44281_",
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:44281";,
[junit4] 2> "shard":null,
[junit4] 2> "numShards":"1",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 1952340 T9402 oasco.ReplicaMutator.updateState Update state
numShards=1 message={
[junit4] 2> "collection":"control_collection",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:44281_",
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:44281";,
[junit4] 2> "shard":null,
[junit4] 2> "numShards":"1",
[junit4] 2> "operation":"state"}
[junit4] 2> 1952340 T9402 oasco.ClusterStateMutator.createCollection
building a new cName: control_collection
[junit4] 2> 1952341 T9402 oasco.ReplicaMutator.updateState Assigning new
node to shard shard=shard1
[junit4] 2> 1952341 T9401 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> 1953339 T9405 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for collection1
[junit4] 2> 1953339 T9405 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:control_collection
[junit4] 2> 1953339 T9405 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 1953340 T9405 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/control_collection
[junit4] 2> 1953340 T9405 oascc.ZkStateReader.readConfigName
path=/collections/control_collection configName=conf1 specified config exists
in ZooKeeper
[junit4] 2> 1953340 T9405 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
FDE5A6ADAAFD4703-001/control-001/cores/collection1/'
[junit4] 2> 1953353 T9405 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 1953355 T9405 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 1953362 T9405 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 1953376 T9405 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.1.0
[junit4] 2> 1953420 T9405 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 1953421 T9405 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 1953429 T9405 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 1953695 T9405 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1953701 T9405 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 1953703 T9405 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1953711 T9405 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1953714 T9405 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1953718 T9405 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1953719 T9405
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1953719 T9405
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1953719 T9405 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1953720 T9405
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1953720 T9405
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1953720 T9405 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection control_collection
[junit4] 2> 1953721 T9405 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1953721 T9405 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
FDE5A6ADAAFD4703-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
FDE5A6ADAAFD4703-001/tempDir-001/control/data/
[junit4] 2> 1953721 T9405 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@23b62fa3
[junit4] 2> 1953722 T9405 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
FDE5A6ADAAFD4703-001/tempDir-001/control/data
[junit4] 2> 1953722 T9405 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
FDE5A6ADAAFD4703-001/tempDir-001/control/data/index/
[junit4] 2> 1953722 T9405 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
FDE5A6ADAAFD4703-001/tempDir-001/control/data/index' doesn't exist. Creating
new index...
[junit4] 2> 1953723 T9405 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
FDE5A6ADAAFD4703-001/tempDir-001/control/data/index
[junit4] 2> 1953723 T9405 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=13, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=74.7001953125,
floorSegmentMB=0.951171875, forceMergeDeletesPctAllowed=11.752308550518705,
segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 1953724 T9405 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@54414b6b
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@abe8904),segFN=segments_1,generation=1}
[junit4] 2> 1953724 T9405 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 1953727 T9405 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 1953727 T9405 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 1953728 T9405 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1953728 T9405 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 1953728 T9405 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1953728 T9405 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1953729 T9405 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1953729 T9405 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 1953729 T9405 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1953730 T9405 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1953730 T9405 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1953730 T9405 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1953731 T9405 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1953731 T9405 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 1953731 T9405 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 1953732 T9405 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 1953732 T9405 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 1953732 T9405 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 1953733 T9405 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 1953733 T9405 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 1953734 T9405 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 1953734 T9405 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 1953735 T9405 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 1953735 T9405 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 1953735 T9405 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 1953736 T9405 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 1953736 T9405 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 1953739 T9405 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1953741 T9405 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1953742 T9405 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1953743 T9405 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1953744 T9405 oasc.SolrCore.initStatsCache Using default
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1953746 T9405 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 1953746 T9405 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 1953747 T9405 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=874284849,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 1953747 T9405 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@54414b6b
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@abe8904),segFN=segments_1,generation=1}
[junit4] 2> 1953747 T9405 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 1953748 T9405 oass.SolrIndexSearcher.<init> Opening
Searcher@583d5707[collection1] main
[junit4] 2> 1953748 T9405 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/control_collection
[junit4] 2> 1953749 T9405 oascc.ZkStateReader.readConfigName
path=/collections/control_collection configName=conf1 specified config exists
in ZooKeeper
[junit4] 2> 1953749 T9405 oasr.ManagedResourceStorage.newStorageIO Setting
up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 1953749 T9405
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 1953749 T9405 oasr.RestManager.init Initializing RestManager
with initArgs: {}
[junit4] 2> 1953750 T9405 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1953750 T9405
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 1953750 T9405 oasr.ManagedResourceStorage.load Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1953751 T9405 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 1953751 T9405 oash.ReplicationHandler.inform Commits will be
reserved for 10000
[junit4] 2> 1953751 T9405 oasc.CoreContainer.registerCore registering
core: collection1
[junit4] 2> 1953751 T9406 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@583d5707[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1953752 T9409 oasc.ZkController.register Register replica -
core:collection1 address:http://127.0.0.1:44281 collection:control_collection
shard:shard1
[junit4] 2> 1953752 T9375 oass.SolrDispatchFilter.init
user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1
[junit4] 2> 1953752 T9375 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 1953752 T9409 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/leader_elect/shard1/election
[junit4] 2> 1953753 T9375
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1953753 T9375 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1953755 T9412 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5c73fe31
name:ZooKeeperConnection Watcher:127.0.0.1:36849/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1953755 T9375 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1953756 T9375 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1953756 T9375
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1953757 T9409 oasc.ShardLeaderElectionContext.runLeaderProcess
Running the leader process for shard shard1
[junit4] 2> 1953758 T9401 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1953758 T9409
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 1953758 T9409 oasc.ShardLeaderElectionContext.runLeaderProcess
I may be the new leader - try and sync
[junit4] 2> ASYNC NEW_CORE C3823 name=collection1
org.apache.solr.core.SolrCore@744ab177 url=http://127.0.0.1:44281/collection1
node=127.0.0.1:44281_ C3823_STATE=coll:control_collection core:collection1
props:{node_name=127.0.0.1:44281_, core=collection1, state=down,
base_url=http://127.0.0.1:44281}
[junit4] 2> 1953758 T9409 C3823 P44281 oasc.SyncStrategy.sync Sync
replicas to http://127.0.0.1:44281/collection1/
[junit4] 2> 1953758 T9402 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> 1953758 T9409 C3823 P44281 oasc.SyncStrategy.syncReplicas Sync
Success - now sync replicas to me
[junit4] 2> 1953759 T9409 C3823 P44281 oasc.SyncStrategy.syncToMe
http://127.0.0.1:44281/collection1/ has no replicas
[junit4] 2> 1953759 T9409 oasc.ShardLeaderElectionContext.runLeaderProcess
I am the new leader: http://127.0.0.1:44281/collection1/ shard1
[junit4] 2> 1953759 T9409 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/leaders/shard1
[junit4] 2> 1953760 T9375 oasc.ChaosMonkey.monkeyLog monkey: init - expire
sessions:false cause connection loss:false
[junit4] 2> 1953762 T9401 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1953763 T9402 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:44281";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 1
[junit4] 2> 1953866 T9401 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> 1953867 T9412 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> 1953913 T9409 oasc.ZkController.register We are
http://127.0.0.1:44281/collection1/ and leader is
http://127.0.0.1:44281/collection1/
[junit4] 2> 1953913 T9409 oasc.ZkController.register No LogReplay needed
for core=collection1 baseURL=http://127.0.0.1:44281
[junit4] 2> 1953913 T9409 oasc.ZkController.checkRecovery I am the leader,
no recovery necessary
[junit4] 2> 1953914 T9409 oasc.ZkController.publish publishing
core=collection1 state=active collection=control_collection
[junit4] 2> 1953914 T9409 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 1953915 T9401 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1953916 T9402 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "collection":"control_collection",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:44281_",
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "state":"active",
[junit4] 2> "base_url":"http://127.0.0.1:44281";,
[junit4] 2> "shard":"shard1",
[junit4] 2> "numShards":"2",
[junit4] 2> "operation":"state"} current state version: 2
[junit4] 2> 1953917 T9402 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "collection":"control_collection",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:44281_",
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "state":"active",
[junit4] 2> "base_url":"http://127.0.0.1:44281";,
[junit4] 2> "shard":"shard1",
[junit4] 2> "numShards":"2",
[junit4] 2> "operation":"state"}
[junit4] 2> 1953987 T9375 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
FDE5A6ADAAFD4703-001/shard-1-001/cores/collection1
[junit4] 2> 1953988 T9375 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1
[junit4] 2> 1953988 T9375 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1953990 T9375 oejs.AbstractConnector.doStart Started
[email protected]:๔๐๐๔๙
[junit4] 2> 1953990 T9375 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@5472fe25
[junit4] 2> 1953990 T9375 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 1953991 T9375 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
FDE5A6ADAAFD4703-001/shard-1-001
[junit4] 2> 1953991 T9375 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
FDE5A6ADAAFD4703-001/shard-1-001/'
[junit4] 2> 1954003 T9375 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
FDE5A6ADAAFD4703-001/shard-1-001/solr.xml
[junit4] 2> 1954013 T9375 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
FDE5A6ADAAFD4703-001/shard-1-001/cores
[junit4] 2> 1954013 T9375 oasc.CoreContainer.<init> New CoreContainer
1225088088
[junit4] 2> 1954013 T9375 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
FDE5A6ADAAFD4703-001/shard-1-001/]
[junit4] 2> 1954014 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 1954014 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 1954014 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 1954014 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 1954015 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 1954015 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 1954015 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 1954015 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 1954015 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 1954016 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 1954016 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting useRetries to: false
[junit4] 2> 1954016 T9375 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1954017 T9375 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1954017 T9375 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1954017 T9375 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 1954017 T9375 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:36849/solr
[junit4] 2> 1954017 T9375 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 1954018 T9375
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1954019 T9375 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1954019 T9412 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> 1954019 T9401 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> 1954020 T9424 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@6d940592
name:ZooKeeperConnection Watcher:127.0.0.1:36849 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1954020 T9375 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1954020 T9375 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1954022 T9375 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1954023 T9427 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@52968210
name:ZooKeeperConnection Watcher:127.0.0.1:36849/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1954023 T9375 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1954027 T9375
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1955029 T9375 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:40049_
[junit4] 2> 1955033 T9375 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:40049_
[junit4] 2> 1955038 T9375 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 1955040 T9375 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
FDE5A6ADAAFD4703-001/shard-1-001/cores
[junit4] 2> 1955041 T9375 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
FDE5A6ADAAFD4703-001/shard-1-001/cores/collection1/
[junit4] 2> 1955041 T9375 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 1955042 T9428 oasc.ZkController.publish publishing
core=collection1 state=down collection=collection1
[junit4] 2> 1955042 T9428 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 1955043 T9428 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 1955043 T9401 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1955044 T9402 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "collection":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:40049_",
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:40049";,
[junit4] 2> "shard":null,
[junit4] 2> "numShards":"2",
[junit4] 2> "operation":"state"} current state version: 3
[junit4] 2> 1955044 T9402 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "collection":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:40049_",
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:40049";,
[junit4] 2> "shard":null,
[junit4] 2> "numShards":"2",
[junit4] 2> "operation":"state"}
[junit4] 2> 1955044 T9402 oasco.ClusterStateMutator.createCollection
building a new cName: collection1
[junit4] 2> 1955045 T9402 oasco.ReplicaMutator.updateState Assigning new
node to shard shard=shard2
[junit4] 2> 1955148 T9427 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1955148 T9401 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1955148 T9412 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1956043 T9428 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for collection1
[junit4] 2> 1956044 T9428 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:collection1
[junit4] 2> 1956045 T9428 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 1956045 T9428 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 1956046 T9428 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 1956046 T9428 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
FDE5A6ADAAFD4703-001/shard-1-001/cores/collection1/'
[junit4] 2> 1956061 T9428 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 1956064 T9428 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 1956069 T9428 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 1956080 T9428 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.1.0
[junit4] 2> 1956102 T9428 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 1956103 T9428 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 1956128 T9428 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 1956321 T9428 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1956324 T9428 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 1956326 T9428 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1956334 T9428 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1956336 T9428 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1956338 T9428 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1956339 T9428
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1956339 T9428
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1956339 T9428 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1956340 T9428
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1956340 T9428
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1956340 T9428 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection collection1
[junit4] 2> 1956340 T9428 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1956340 T9428 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
FDE5A6ADAAFD4703-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
FDE5A6ADAAFD4703-001/tempDir-001/jetty1/
[junit4] 2> 1956341 T9428 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@23b62fa3
[junit4] 2> 1956341 T9428 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
FDE5A6ADAAFD4703-001/tempDir-001/jetty1
[junit4] 2> 1956342 T9428 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
FDE5A6ADAAFD4703-001/tempDir-001/jetty1/index/
[junit4] 2> 1956342 T9428 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
FDE5A6ADAAFD4703-001/tempDir-001/jetty1/index' doesn't exist. Creating new
index...
[junit4] 2> 1956342 T9428 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
FDE5A6ADAAFD4703-001/tempDir-001/jetty1/index
[junit4] 2> 1956343 T9428 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=13, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=74.7001953125,
floorSegmentMB=0.951171875, forceMergeDeletesPctAllowed=11.752308550518705,
segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 1956343 T9428 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@2332dc92
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@602f074b),segFN=segments_1,generation=1}
[junit4] 2> 1956344 T9428 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 1956348 T9428 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 1956348 T9428 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 1956349 T9428 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1956349 T9428 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 1956349 T9428 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1956349 T9428 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1956350 T9428 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1956350 T9428 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 1956350 T9428 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1956351 T9428 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1956351 T9428 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1956352 T9428 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1956352 T9428 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1956352 T9428 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 1956352 T9428 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 1956353 T9428 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 1956353 T9428 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 1956354 T9428 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 1956355 T9428 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 1956355 T9428 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 1956356 T9428 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 1956356 T9428 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 1956357 T9428 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 1956357 T9428 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 1956358 T9428 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 1956358 T9428 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 1956359 T9428 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 1956362 T9428 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1956363 T9428 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1956364 T9428 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1956365 T9428 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1956366 T9428 oasc.SolrCore.initStatsCache Using default
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1956367 T9428 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 1956367 T9428 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 1956368 T9428 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=874284849,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 1956369 T9428 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@2332dc92
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@602f074b),segFN=segments_1,generation=1}
[junit4] 2> 1956369 T9428 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 1956369 T9428 oass.SolrIndexSearcher.<init> Opening
Searcher@57e5c6bf[collection1] main
[junit4] 2> 1956369 T9428 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 1956370 T9428 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 1956370 T9428 oasr.ManagedResourceStorage.newStorageIO Setting
up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 1956371 T9428
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 1956371 T9428 oasr.RestManager.init Initializing RestManager
with initArgs: {}
[junit4] 2> 1956371 T9428 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1956371 T9428
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 1956372 T9428 oasr.ManagedResourceStorage.load Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1956372 T9428 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 1956372 T9428 oash.ReplicationHandler.inform Commits will be
reserved for 10000
[junit4] 2> 1956373 T9429 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@57e5c6bf[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1956373 T9428 oasc.CoreContainer.registerCore registering
core: collection1
[junit4] 2> 1956388 T9432 oasc.ZkController.register Register replica -
core:collection1 address:http://127.0.0.1:40049 collection:collection1
shard:shard2
[junit4] 2> 1956389 T9375 oass.SolrDispatchFilter.init
user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1
[junit4] 2> 1956389 T9375 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 1956390 T9432 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leader_elect/shard2/election
[junit4] 2> 1956396 T9432 oasc.ShardLeaderElectionContext.runLeaderProcess
Running the leader process for shard shard2
[junit4] 2> 1956398 T9401 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1956399 T9432
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 1956399 T9432 oasc.ShardLeaderElectionContext.runLeaderProcess
I may be the new leader - try and sync
[junit4] 2> ASYNC NEW_CORE C3824 name=collection1
org.apache.solr.core.SolrCore@682ea45b url=http://127.0.0.1:40049/collection1
node=127.0.0.1:40049_ C3824_STATE=coll:collection1 core:collection1
props:{node_name=127.0.0.1:40049_, core=collection1, state=down,
base_url=http://127.0.0.1:40049}
[junit4] 2> 1956399 T9432 C3824 P40049 oasc.SyncStrategy.sync Sync
replicas to http://127.0.0.1:40049/collection1/
[junit4] 2> 1956399 T9402 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"collection1"} current state version: 4
[junit4] 2> 1956399 T9432 C3824 P40049 oasc.SyncStrategy.syncReplicas Sync
Success - now sync replicas to me
[junit4] 2> 1956400 T9432 C3824 P40049 oasc.SyncStrategy.syncToMe
http://127.0.0.1:40049/collection1/ has no replicas
[junit4] 2> 1956400 T9432 oasc.ShardLeaderElectionContext.runLeaderProcess
I am the new leader: http://127.0.0.1:40049/collection1/ shard2
[junit4] 2> 1956400 T9432 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leaders/shard2
[junit4] 2> 1956404 T9401 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1956405 T9402 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "base_url":"http://127.0.0.1:40049";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 4
[junit4] 2> 1956507 T9401 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1956507 T9427 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1956507 T9412 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1956555 T9432 oasc.ZkController.register We are
http://127.0.0.1:40049/collection1/ and leader is
http://127.0.0.1:40049/collection1/
[junit4] 2> 1956556 T9432 oasc.ZkController.register No LogReplay needed
for core=collection1 baseURL=http://127.0.0.1:40049
[junit4] 2> 1956556 T9432 oasc.ZkController.checkRecovery I am the leader,
no recovery necessary
[junit4] 2> 1956556 T9432 oasc.ZkController.publish publishing
core=collection1 state=active collection=collection1
[junit4] 2> 1956556 T9432 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 1956557 T9401 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1956558 T9402 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "collection":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:40049_",
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "state":"active",
[junit4] 2> "base_url":"http://127.0.0.1:40049";,
[junit4] 2> "shard":"shard2",
[junit4] 2> "numShards":"2",
[junit4] 2> "operation":"state"} current state version: 5
[junit4] 2> 1956558 T9402 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "collection":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:40049_",
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "state":"active",
[junit4] 2> "base_url":"http://127.0.0.1:40049";,
[junit4] 2> "shard":"shard2",
[junit4] 2> "numShards":"2",
[junit4] 2> "operation":"state"}
[junit4] 2> 1956609 T9375 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
FDE5A6ADAAFD4703-001/shard-2-001/cores/collection1
[junit4] 2> 1956610 T9375 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2
[junit4] 2> 1956610 T9375 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1956612 T9375 oejs.AbstractConnector.doStart Started
[email protected]:๔๑๗๑๑
[junit4] 2> 1956613 T9375 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@5472fe25
[junit4] 2> 1956613 T9375 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 1956613 T9375 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
FDE5A6ADAAFD4703-001/shard-2-001
[junit4] 2> 1956613 T9375 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
FDE5A6ADAAFD4703-001/shard-2-001/'
[junit4] 2> 1956624 T9375 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
FDE5A6ADAAFD4703-001/shard-2-001/solr.xml
[junit4] 2> 1956633 T9375 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
FDE5A6ADAAFD4703-001/shard-2-001/cores
[junit4] 2> 1956634 T9375 oasc.CoreContainer.<init> New CoreContainer
835649386
[junit4] 2> 1956634 T9375 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
FDE5A6ADAAFD4703-001/shard-2-001/]
[junit4] 2> 1956635 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 1956635 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 1956635 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 1956635 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 1956635 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 1956635 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 1956636 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 1956636 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 1956636 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 1956636 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 1956636 T9375 oashc.HttpShardHandlerFactory.getParameter
Setting useRetries to: false
[junit4] 2> 1956637 T9375 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1956637 T9375 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1956637 T9375 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1956637 T9375 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 1956638 T9375 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:36849/solr
[junit4] 2> 1956638 T9375 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 1956638 T9375
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1956639 T9375 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1956641 T9444 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@4ac49fab
name:ZooKeeperConnection Watcher:127.0.0.1:36849 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1956641 T9375 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1956642 T9375 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1956644 T9375 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1956646 T9447 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@4401896f
name:ZooKeeperConnection Watcher:127.0.0.1:36849/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1956647 T9375 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1956653 T9375
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1956660 T9447 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1956661 T9401 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1956660 T9427 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1956660 T9412 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1957655 T9375 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41711_
[junit4] 2> 1957656 T9375 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:41711_
[junit4] 2> 1957659 T9375 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 1957661 T9375 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
FDE5A6ADAAFD4703-001/shard-2-001/cores
[junit4] 2> 1957661 T9375 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
FDE5A6ADAAFD4703-001/shard-2-001/cores/collection1/
[junit4] 2> 1957661 T9375 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 1957662 T9448 oasc.ZkController.publish publishing
core=collection1 state=down collection=collection1
[junit4] 2> 1957662 T9448 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 1957663 T9401 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1957663 T9448 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 1957663 T9402 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "collection":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:41711_",
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:41711";,
[junit4] 2> "shard":null,
[junit4] 2> "numShards":"2",
[junit4] 2> "operation":"state"} current state version: 6
[junit4] 2> 1957664 T9402 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "collection":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:41711_",
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:41711";,
[junit4] 2> "shard":null,
[junit4] 2> "numShards":"2",
[junit4] 2> "operation":"state"}
[junit4] 2> 1957664 T9402 oasco.ReplicaMutator.updateState Collection
already exists with numShards=2
[junit4] 2> 1957664 T9402 oasco.ReplicaMutator.updateState Assigning new
node to shard shard=shard1
[junit4] 2> 1957766 T9401 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1957766 T9427 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1957766 T9412 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1957766 T9447 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1958663 T9448 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for collection1
[junit4] 2> 1958663 T9448 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:collection1
[junit4] 2> 1958664 T9448 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 1958664 T9448 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 1958665 T9448 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 1958665 T9448 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
FDE5A6ADAAFD4703-001/shard-2-001/cores/collection1/'
[junit4] 2> 1958674 T9448 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 1958675 T9448 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 1958680 T9448 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 1958690 T9448 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.1.0
[junit4] 2> 1958711 T9448 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 1958712 T9448 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 1958717 T9448 oass.IndexSchema.readSchema [collection1] Schema
name=test
[junit4] 2> 1958924 T9448 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1958927 T9448 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 1958929 T9448 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1958937 T9448 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1958939 T9448 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1958941 T9448 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1958942 T9448
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1958942 T9448
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1958942 T9448 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1958943 T9448
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1958943 T9448
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1958943 T9448 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection collection1
[junit4] 2> 1958944 T9448 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1958944 T9448 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
FDE5A6ADAAFD4703-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
FDE5A6ADAAFD4703-001/tempDir-001/jetty2/
[junit4] 2> 1958944 T9448 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@23b62fa3
[junit4] 2> 1958944 T9448 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
FDE5A6ADAAFD4703-001/tempDir-001/jetty2
[junit4] 2> 1958945 T9448 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
FDE5A6ADAAFD4703-001/tempDir-001/jetty2/index/
[junit4] 2> 1958945 T9448 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
FDE5A6ADAAFD4703-001/tempDir-001/jetty2/index' doesn't exist. Creating new
index...
[junit4] 2> 1958945 T9448 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
FDE5A6ADAAFD4703-001/tempDir-001/jetty2/index
[junit4] 2> 1958945 T9448 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=13, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=74.7001953125,
floorSegmentMB=0.951171875, forceMergeDeletesPctAllowed=11.752308550518705,
segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 1958946 T9448 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1073da0a
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@25efcef6),segFN=segments_1,generation=1}
[junit4] 2> 1958946 T9448 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 1958950 T9448 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 1958950 T9448 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 1958950 T9448 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1958951 T9448 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 1958951 T9448 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1958951 T9448 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1958951 T9448 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1958952 T9448 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 1958952 T9448 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1958952 T9448 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1958953 T9448 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1958953 T9448 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1958954 T9448 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1958954 T9448 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 1958955 T9448 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 1958955 T9448 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 1958956 T9448 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 1958956 T9448 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 1958957 T9448 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 1958957 T9448 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 1958958 T9448 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 1958958 T9448 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 1958959 T9448 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 1958959 T9448 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 1958960 T9448 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 1958960 T9448 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 1958960 T9448 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 1958963 T9448 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1958964 T9448 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1958965 T9448 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1958966 T9448 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1958967 T9448 oasc.SolrCore.initStatsCache Using default
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1958968 T9448 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 1958968 T9448 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 1958968 T9448 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=874284849,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 1958969 T9448 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@1073da0a
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@25efcef6),segFN=segments_1,generation=1}
[junit4] 2> 1958969 T9448 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 1958969 T9448 oass.SolrIndexSearcher.<init> Opening
Searcher@484e8c0a[collection1] main
[junit4] 2> 1958969 T9448 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 1958971 T9448 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 1958971 T9448 oasr.ManagedResourceStorage.newStorageIO Setting
up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 1958971 T9448
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 1958972 T9448 oasr.RestManager.init Initializing RestManager
with initArgs: {}
[junit4] 2> 1958972 T9448 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1958972 T9448
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 1958973 T9448 oasr.ManagedResourceStorage.load Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1958973 T9448 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 1958973 T9448 oash.ReplicationHandler.inform Commits will be
reserved for 10000
[junit4] 2> 1958974 T9449 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@484e8c0a[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1958974 T9448 oasc.CoreContainer.registerCore registering
core: collection1
[junit4] 2> 1958975 T9452 oasc.ZkController.register Register replica -
core:collection1 address:http://127.0.0.1:41711 collection:collection1
shard:shard1
[junit4] 2> 1958975 T9375 oass.SolrDispatchFilter.init
user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1
[junit4] 2> 1958976 T9375 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 1958976 T9452 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leader_elect/shard1/election
[junit4] 2> 1958981 T9452 oasc.ShardLeaderElectionContext.runLeaderProcess
Running the leader process for shard shard1
[junit4] 2> 1958984 T9401 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1958984 T9452
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 1958984 T9452 oasc.ShardLeaderElectionContext.runLeaderProcess
I may be the new leader - try and sync
[junit4] 2> ASYNC NEW_CORE C3825 name=collection1
org.apache.solr.core.SolrCore@2b9fddb5 url=http://127.0.0.1:41711/collection1
node=127.0.0.1:41711_ C3825_STATE=coll:collection1 core:collection1
props:{node_name=127.0.0.1:41711_, core=collection1, state=down,
base_url=http://127.0.0.1:41711}
[junit4] 2> 1958984 T9452 C3825 P41711 oasc.SyncStrategy.sync Sync
replicas to http://127.0.0.1:41711/collection1/
[junit4] 2> 1958985 T9452 C3825 P41711 oasc.SyncStrategy.syncReplicas Sync
Success - now sync replicas to me
[junit4] 2> 1958985 T9452 C3825 P41711 oasc.S
[...truncated too long message...]
olr.handler.TestBlobHandler FDE5A6ADAAFD4703-001/tempDir-001/jetty4
[junit4] 2> 1973557 T9375 oasc.Overseer.close Overseer
(id=93246335553241100-127.0.0.1:36894_-n_0000000004) closing
[junit4] 2> 1973557 T9536 oasc.Overseer$ClusterStateUpdater.run Overseer
Loop exiting : 127.0.0.1:36894_
[junit4] 2> 1975059 T9489 oascc.ZkStateReader$3.process WARN ZooKeeper
watch triggered, but Solr cannot talk to ZK
[junit4] 2> 1975080 T9375 oejsh.ContextHandler.doStop stopped
o.e.j.s.ServletContextHandler{/,null}
[junit4] 2> 1975272 T9375 oasc.ZkTestServer.send4LetterWord connecting to
127.0.0.1:36849 36849
[junit4] 2> 1975814 T9376 oasc.ZkTestServer.send4LetterWord connecting to
127.0.0.1:36849 36849
[junit4] 2> 1975817 T9376 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> 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> 4 /solr/overseer/queue
[junit4] 2>
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestBlobHandler
-Dtests.method=doBlobHandlerTest -Dtests.seed=FDE5A6ADAAFD4703
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=th_TH_TH_#u-nu-thai
-Dtests.timezone=America/Mazatlan -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] FAILURE 23.9s J1 | TestBlobHandler.doBlobHandlerTest <<<
[junit4] > Throwable #1: java.lang.AssertionError:
{responseHeader={status=0, QTime=0}, response={numFound=0, start=0, docs=[]}}
[junit4] > at
__randomizedtesting.SeedInfo.seed([FDE5A6ADAAFD4703:1D2484FF111131F1]: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> 1975826 T9375 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
FDE5A6ADAAFD4703-001
[junit4] 2> 23945 T9374 ccr.ThreadLeakControl.checkThreadLeaks WARNING
Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50):
{timestamp=PostingsFormat(name=LuceneFixedGap), id=Lucene50(blocksize=128),
blobName=PostingsFormat(name=LuceneFixedGap),
md5=PostingsFormat(name=LuceneFixedGap), version=PostingsFormat(name=Direct),
size=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
_version_=PostingsFormat(name=Direct)}, docValues:{}, sim=DefaultSimilarity,
locale=th_TH_TH_#u-nu-thai, timezone=America/Mazatlan
[junit4] 2> NOTE: Linux 3.13.0-44-generic amd64/Oracle Corporation
1.7.0_76 (64-bit)/cpus=8,threads=1,free=240531440,total=321536000
[junit4] 2> NOTE: All tests run in this JVM: [TestSolrJ,
HdfsWriteToMultipleCollectionsTest, TestMissingGroups, SimplePostToolTest,
TestPHPSerializedResponseWriter, TestJoin, AliasIntegrationTest,
TestFastOutputStream, DirectUpdateHandlerOptimizeTest, TestQuerySenderListener,
TestSolrConfigHandlerCloud, SuggesterTSTTest, TestLuceneMatchVersion,
TestReRankQParserPlugin, ZkNodePropsTest, FileBasedSpellCheckerTest,
TestSolrQueryParserDefaultOperatorResource, QueryParsingTest,
TestSuggestSpellingConverter, BadIndexSchemaTest, SolrRequestParserTest,
TestHighFrequencyDictionaryFactory, TestStandardQParsers,
CSVRequestHandlerTest, TermVectorComponentDistributedTest,
FieldMutatingUpdateProcessorTest, JsonLoaderTest, ExternalFileFieldSortTest,
PolyFieldTest, TestSolrXml, SchemaVersionSpecificBehaviorTest,
TestOverriddenPrefixQueryForCustomFieldType, CurrencyFieldXmlFileTest,
TestConfigReload, CopyFieldTest, BasicDistributedZk2Test,
IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestDocBasedVersionConstraints,
ExternalCollectionsTest, ExitableDirectoryReaderTest, StatsComponentTest,
TestCloudManagedSchema, TestDocSet, TestQuerySenderNoQuery, TestRecovery,
TestBulkSchemaConcurrent, BufferStoreTest, TestRequestStatusCollectionAPI,
SearchHandlerTest, CloudExitableDirectoryReaderTest, TestCloudInspectUtil,
TestBlendedInfixSuggestions, TestDynamicFieldResource,
WordBreakSolrSpellCheckerTest, TestSerializedLuceneMatchVersion,
UpdateRequestProcessorFactoryTest, ShardSplitTest, DateMathParserTest,
SpellPossibilityIteratorTest, HighlighterConfigTest, InfoHandlerTest,
HdfsSyncSliceTest, ZkSolrClientTest, ReplicationFactorTest,
TestRandomMergePolicy, TestPseudoReturnFields, EnumFieldTest,
DistributedFacetPivotLargeTest, BlockDirectoryTest,
TestDefaultSimilarityFactory, DistributedQueryComponentOptimizationTest,
TestSortingResponseWriter, TestRestManager, TestSolr4Spatial2,
TestIntervalFaceting, AsyncMigrateRouteKeyTest, TestShortCircuitedRequests,
TermsComponentTest, TestCloudPivotFacet, RecoveryAfterSoftCommitTest,
TestConfig, TestFieldSortValues, StandardRequestHandlerTest, PluginInfoTest,
LeaderFailoverAfterPartitionTest, SolrCmdDistributorTest, SolrXmlInZkTest,
BinaryUpdateRequestHandlerTest, TestMiniSolrCloudClusterSSL,
TestImplicitCoreProperties, ReturnFieldsTest, SpellCheckCollatorTest,
HttpPartitionTest, TestCopyFieldCollectionResource, TestExactStatsCache,
TestMergePolicyConfig, OverseerCollectionProcessorTest,
SharedFSAutoReplicaFailoverUtilsTest, TestSolrQueryParser,
FastVectorHighlighterTest, TestLeaderElectionZkExpiry, TestRawResponseWriter,
DistributedQueryComponentCustomSortTest, AnalyticsQueryTest,
MoreLikeThisHandlerTest, BasicFunctionalityTest, TestTrie,
SignatureUpdateProcessorFactoryTest, ConnectionManagerTest,
OpenCloseCoreStressTest, TestRealTimeGet, TestSolrConfigHandlerConcurrent,
LeaderElectionIntegrationTest, BasicZkTest, TestReplicationHandler,
TestRandomDVFaceting, TestDistributedGrouping, TestStressVersions,
DistributedTermsComponentTest, TestSolr4Spatial, SpellCheckComponentTest,
QueryElevationComponentTest, PeerSyncTest, ConvertedLegacyTest, TestFiltering,
TestFoldingMultitermQuery, SpatialFilterTest, SuggesterWFSTTest,
TestAtomicUpdateErrorCases, StatelessScriptUpdateProcessorFactoryTest,
TestRemoteStreaming, XsltUpdateRequestHandlerTest, CacheHeaderTest,
TestSurroundQueryParser, TestQueryUtils, TestReversedWildcardFilterFactory,
TestQueryTypes, TestOmitPositions, RequestHandlersTest, TestValueSourceCache,
TermVectorComponentTest, RequiredFieldsTest, FieldAnalysisRequestHandlerTest,
TestArbitraryIndexDir, SolrPluginUtilsTest, TestJmxIntegration,
MBeansHandlerTest, PingRequestHandlerTest, TestLFUCache, UpdateParamsTest,
SolrIndexConfigTest, TestSolrDeletionPolicy2, MultiTermTest, TestSearchPerf,
NumericFieldsTest, MinimalSchemaTest, TestFuzzyAnalyzedSuggestions,
TestSolrCoreProperties, NotRequiredUniqueKeyTest, TestCodecSupport,
EchoParamsTest, TestSweetSpotSimilarityFactory, TestDFRSimilarityFactory,
TestPerFieldSimilarity, TestLMDirichletSimilarityFactory,
TestLMJelinekMercerSimilarityFactory, TestIBSimilarityFactory,
TestBM25SimilarityFactory, TestFastWriter, ResourceLoaderTest,
OpenExchangeRatesOrgProviderTest, TestFastLRUCache,
ChaosMonkeyNothingIsSafeTest, PreAnalyzedFieldTest, TestSystemIdResolver,
PrimUtilsTest, DateFieldTest, SpellingQueryConverterTest,
RAMDirectoryFactoryTest, ClusterStateTest, TestUtils, TestDocumentBuilder,
SystemInfoHandlerTest, UUIDFieldTest, FileUtilsTest, TestRTGBase,
CursorPagingTest, TestTolerantSearch, AssignTest, CustomCollectionTest,
DeleteLastCustomShardedReplicaTest, DeleteReplicaTest, MigrateRouteKeyTest,
OutOfBoxZkACLAndCredentialsProvidersTest,
OverriddenZkACLAndCredentialsProvidersTest, OverseerStatusTest,
SSLMigrationTest, SaslZkACLProviderTest, SharedFSAutoReplicaFailoverTest,
TestCollectionAPI, TestReplicaProperties, TriLevelCompositeIdRoutingTest,
TestInfoStreamLogging, TestNRTOpen, TestReloadAndDeleteDocs,
TestShardHandlerFactory, TestSolrConfigHandler, TestBlobHandler]
[junit4] Completed on J1 in 24.22s, 1 test, 1 failure <<< FAILURES!
[...truncated 167 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, 1848 tests, 1 failure, 46 ignored (21
assumptions)
Total time: 63 minutes 58 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.7.0_76
-XX:+UseCompressedOops -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]
