Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Linux/11610/
Java: 32bit/jdk1.7.0_67 -client -XX:+UseConcMarkSweepGC (asserts: true)
1 tests failed.
FAILED: org.apache.solr.schema.TestBulkSchemaConcurrent.testDistribSearch
Error Message:
Stack Trace:
java.lang.NullPointerException
at
__randomizedtesting.SeedInfo.seed([58D29EBE8B2EC667:D93410A6FC71A65B]:0)
at
org.apache.solr.schema.TestBulkSchemaConcurrent.doTest(TestBulkSchemaConcurrent.java:108)
at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
at sun.reflect.GeneratedMethodAccessor55.invoke(Unknown Source)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 10427 lines...]
[junit4] Suite: org.apache.solr.schema.TestBulkSchemaConcurrent
[junit4] 2> Creating dataDir:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/init-core-data-001
[junit4] 2> 3545379 T10219 oas.SolrTestCaseJ4.buildSSLConfig Randomized
ssl (true) and clientAuth (false)
[junit4] 2> 3545379 T10219
oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system
property: /
[junit4] 2> 3545384 T10219 oas.SolrTestCaseJ4.setUp ###Starting
testDistribSearch
[junit4] 2> 3545385 T10219 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 3545385 T10220 oasc.ZkTestServer$ZKServerMain.runFromConfig
Starting server
[junit4] 2> 3545485 T10219 oasc.ZkTestServer.run start zk server on
port:33591
[junit4] 2> 3545486 T10219
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3545486 T10219 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3545492 T10227 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@e270d9 name:ZooKeeperConnection
Watcher:127.0.0.1:33591 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 3545492 T10219 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3545493 T10219 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3545493 T10219 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 3545495 T10219
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3545496 T10219 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3545497 T10230 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1ade921 name:ZooKeeperConnection
Watcher:127.0.0.1:33591/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 3545497 T10219 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3545497 T10219 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3545498 T10219 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 3545499 T10219 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 3545501 T10219 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 3545502 T10219 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 3545503 T10219 oasc.AbstractZkTestCase.putConfig put
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig-managed-schema.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 3545503 T10219 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 3545505 T10219 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> 3545506 T10219 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 3545507 T10219 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> 3545508 T10219 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 3545509 T10219 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> 3545510 T10219 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 3545511 T10219 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> 3545511 T10219 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 3545513 T10219 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> 3545513 T10219 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 3545514 T10219 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> 3545515 T10219 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 3545516 T10219 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> 3545516 T10219 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 3545518 T10219 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> 3545518 T10219 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 3545519 T10219 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> 3545520 T10219 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 3545521 T10219 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> 3545521 T10219 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> 3545523 T10219
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3545524 T10219 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3545525 T10233 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@357acb name:ZooKeeperConnection
Watcher:127.0.0.1:33591/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 3545525 T10219 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3545525 T10219 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3545779 T10219 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3545782 T10219 oejus.SslContextFactory.doStart Enabled
Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3,
TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 3545783 T10219 oejs.AbstractConnector.doStart Started
[email protected]:47713
[junit4] 2> 3545785 T10219 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 3545786 T10219 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 3545786 T10219 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-002
[junit4] 2> 3545786 T10219 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-002/'
[junit4] 2> 3545802 T10219 oasc.ConfigSolr.fromFile Loading container
configuration from
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-002/solr.xml
[junit4] 2> 3545832 T10219 oasc.CoreContainer.<init> New CoreContainer
3319522
[junit4] 2> 3545833 T10219 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-002/]
[junit4] 2> 3545833 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 3545834 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 3545834 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 3545834 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 3545835 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 3545835 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 3545835 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 3545836 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 3545836 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 3545836 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 3545838 T10219 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 3545839 T10219 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3545839 T10219 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3545839 T10219 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3545840 T10219 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:33591/solr
[junit4] 2> 3545840 T10219 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 3545840 T10219
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3545841 T10219 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3545842 T10245 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@189ec93 name:ZooKeeperConnection
Watcher:127.0.0.1:33591 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 3545843 T10219 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3545843 T10219 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3545844 T10219 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3545845 T10248 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@2608ad name:ZooKeeperConnection
Watcher:127.0.0.1:33591/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 3545845 T10219 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3545846 T10219 oascc.SolrZkClient.makePath makePath:
/overseer/queue
[junit4] 2> 3545848 T10219 oascc.SolrZkClient.makePath makePath:
/overseer/collection-queue-work
[junit4] 2> 3545850 T10219 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-running
[junit4] 2> 3545851 T10219 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-completed
[junit4] 2> 3545853 T10219 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-failure
[junit4] 2> 3545855 T10219 oascc.SolrZkClient.makePath makePath:
/live_nodes
[junit4] 2> 3545856 T10219 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:47713_
[junit4] 2> 3545857 T10219 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:47713_
[junit4] 2> 3545858 T10219 oascc.SolrZkClient.makePath makePath:
/overseer_elect
[junit4] 2> 3545859 T10219 oascc.SolrZkClient.makePath makePath:
/overseer_elect/election
[junit4] 2> 3545861 T10219 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 3545862 T10219 oasc.OverseerElectionContext.runLeaderProcess I
am going to be the leader 127.0.0.1:47713_
[junit4] 2> 3545862 T10219 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 3545863 T10219 oasc.Overseer.start Overseer
(id=93001064867758084-127.0.0.1:47713_-n_0000000000) starting
[junit4] 2> 3545865 T10219 oascc.SolrZkClient.makePath makePath:
/overseer/queue-work
[junit4] 2> 3545870 T10219 oasc.OverseerAutoReplicaFailoverThread.<init>
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 3545871 T10250 oasc.OverseerCollectionProcessor.run Process
current queue of collection creations
[junit4] 2> 3545871 T10219 oascc.SolrZkClient.makePath makePath:
/clusterstate.json
[junit4] 2> 3545873 T10219 oascc.SolrZkClient.makePath makePath:
/aliases.json
[junit4] 2> 3545874 T10219
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 3545878 T10249 oasc.Overseer$ClusterStateUpdater.run Starting
to work on the main queue
[junit4] 2> 3545879 T10252 oasc.ZkController.publish publishing
core=collection1 state=down collection=control_collection
[junit4] 2> 3545879 T10252 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 3545880 T10248 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 3545880 T10252 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 3545882 T10249 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 0, message = {
[junit4] 2> "collection":"control_collection",
[junit4] 2> "shard":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "base_url":"https://127.0.0.1:47713";,
[junit4] 2> "roles":null,
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"1",
[junit4] 2> "node_name":"127.0.0.1:47713_",
[junit4] 2> "state":"down"} current state version: 0
[junit4] 2> 3545883 T10249 oasco.ReplicaMutator.updateState Update state
numShards=1 message={
[junit4] 2> "collection":"control_collection",
[junit4] 2> "shard":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "base_url":"https://127.0.0.1:47713";,
[junit4] 2> "roles":null,
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"1",
[junit4] 2> "node_name":"127.0.0.1:47713_",
[junit4] 2> "state":"down"}
[junit4] 2> 3545883 T10249 oasco.ClusterStateMutator.createCollection
building a new cName: control_collection
[junit4] 2> 3545884 T10249 oasco.ReplicaMutator.updateState Assigning new
node to shard shard=shard1
[junit4] 2> 3545885 T10248 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> 3546881 T10252 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for collection1
[junit4] 2> 3546881 T10252 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:control_collection
[junit4] 2> 3546882 T10252 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 3546882 T10252 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/control_collection
[junit4] 2> 3546883 T10252 oascc.ZkStateReader.readConfigName
path=/collections/control_collection configName=conf1 specified config exists
in ZooKeeper
[junit4] 2> 3546883 T10252 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-002/collection1/'
[junit4] 2> 3546884 T10252 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-002/collection1/lib/.svn/'
to classloader
[junit4] 2> 3546884 T10252 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-002/collection1/lib/classes/'
to classloader
[junit4] 2> 3546884 T10252 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-002/collection1/lib/README'
to classloader
[junit4] 2> 3546900 T10252 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 3546903 T10252 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 3546923 T10252 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 3546961 T10252 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 3546962 T10252 oass.ManagedIndexSchemaFactory.create The
schema is configured as managed, but managed schema resource managed-schema not
found - loading non-managed schema schema.xml instead
[junit4] 2> 3546963 T10252 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 3546970 T10252 oass.IndexSchema.readSchema [collection1]
Schema name=test
[junit4] 2> 3547207 T10252 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3547212 T10252 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 3547215 T10252 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3547223 T10252 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3547225 T10252 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3547228 T10252 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3547228 T10252
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3547229 T10252
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3547229 T10252 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3547230 T10252
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3547230 T10252
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3547232 T10252
oass.ManagedIndexSchema.persistManagedSchemaToZooKeeper Created and persisted
managed schema znode at /configs/conf1/managed-schema
[junit4] 2> 3547233 T10252 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml.bak
[junit4] 2> 3547235 T10252
oass.ManagedIndexSchemaFactory.zkUgradeToManagedSchema After upgrading to
managed schema in ZooKeeper, renamed the non-managed schema
/configs/conf1/schema.xml to /configs/conf1/schema.xml.bak
[junit4] 2> 3547235 T10252 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection control_collection
[junit4] 2> 3547235 T10252 oasc.SolrCore.initDirectoryFactory
solr.NRTCachingDirectoryFactory
[junit4] 2> 3547235 T10252 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-002/collection1/,
dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-002/collection1/data/
[junit4] 2> 3547236 T10252 oasc.SolrCore.<init> JMX monitoring not
detected for core: collection1
[junit4] 2> 3547236 T10252 oasc.CachingDirectoryFactory.get return new
directory for
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-002/collection1/data
[junit4] 2> 3547237 T10252 oasc.SolrCore.getNewIndexDir New index
directory detected: old=null
new=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-002/collection1/data/index/
[junit4] 2> 3547237 T10252 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-002/collection1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 3547237 T10252 oasc.CachingDirectoryFactory.get return new
directory for
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-002/collection1/data/index
[junit4] 2> 3547238 T10252 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=46, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=93.640625,
floorSegmentMB=1.021484375, forceMergeDeletesPctAllowed=9.546037337096186,
segmentsPerTier=50.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.14997496414427386
[junit4] 2> 3547406 T10252 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=NRTCachingDirectory(NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-002/collection1/data/index
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f5f267;
maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 3547406 T10252 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 3547407 T10252 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3547408 T10252 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3547408 T10252 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3547408 T10252 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3547409 T10252 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3547409 T10252 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 3547409 T10252 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 3547410 T10252 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 3547410 T10252 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 3547410 T10252 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 3547411 T10252 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 3547411 T10252 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 3547412 T10252 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 3547412 T10252 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 3547412 T10252 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 3547413 T10252 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 3547413 T10252 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
[junit4] 2> 3547413 T10252 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 3547414 T10252 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 3547414 T10252 oasc.RequestHandlers.initHandlersFromConfig
created /dump: DumpRequestHandler
[junit4] 2> 3547417 T10252 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3547418 T10252 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3547420 T10252 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3547421 T10252 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3547421 T10252 oasc.RequestHandlers.applyInitParams WARN
INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class
= DumpRequestHandler,args = {defaults={a=A,b=B}}}
[junit4] 2> 3547423 T10252 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 3547423 T10252 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 3547424 T10252 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=33,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4889115969760214]
[junit4] 2> 3547425 T10252 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=NRTCachingDirectory(NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-002/collection1/data/index
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f5f267;
maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 3547425 T10252 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 3547425 T10252 oass.SolrIndexSearcher.<init> Opening
Searcher@1ea451f[collection1] main
[junit4] 2> 3547426 T10252 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/control_collection
[junit4] 2> 3547427 T10252 oascc.ZkStateReader.readConfigName
path=/collections/control_collection configName=conf1 specified config exists
in ZooKeeper
[junit4] 2> 3547427 T10252 oasr.ManagedResourceStorage.newStorageIO
Setting up ZooKeeper-based storage for the RestManager with znodeBase:
/configs/conf1
[junit4] 2> 3547427 T10252
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 3547428 T10252 oasr.RestManager.init Initializing RestManager
with initArgs: {}
[junit4] 2> 3547428 T10252 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 3547429 T10252
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 3547429 T10252 oasr.ManagedResourceStorage.load Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 3547430 T10252 oascc.SolrZkClient.makePath makePath:
/configs/conf1/_rest_managed.json
[junit4] 2> 3547431 T10252
oasr.ManagedResourceStorage$ZooKeeperStorageIO$1.close Wrote 38 bytes to new
znode /configs/conf1/_rest_managed.json
[junit4] 2> 3547432 T10252 oasr.ManagedResourceStorage$JsonStorage.store
Saved JSON object to path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 3547432 T10252 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 3547432 T10252 oass.ZkIndexSchemaReader.createSchemaWatcher
Creating ZooKeeper watch for the managed schema at /configs/conf1/managed-schema
[junit4] 2> 3547433 T10252 oash.ReplicationHandler.inform Commits will be
reserved for 10000
[junit4] 2> 3547433 T10253 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@1ea451f[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 3547433 T10252 oasc.CoreContainer.registerCore registering
core: collection1
[junit4] 2> 3547434 T10256 oasc.ZkController.register Register replica -
core:collection1 address:https://127.0.0.1:47713 collection:control_collection
shard:shard1
[junit4] 2> 3547434 T10219 oass.SolrDispatchFilter.init
user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0
[junit4] 2> 3547434 T10219 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 3547434 T10256 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/leader_elect/shard1/election
[junit4] 2> 3547437 T10219
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3547438 T10219 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3547438 T10256
oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for
shard shard1
[junit4] 2> 3547439 T10259 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@115bf59 name:ZooKeeperConnection
Watcher:127.0.0.1:33591/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 3547439 T10219 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3547440 T10248 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 3547440 T10219 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3547440 T10256
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 3547441 T10256
oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try
and sync
[junit4] 2> 3547440 T10249 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> ASYNC NEW_CORE C6789 name=collection1
org.apache.solr.core.SolrCore@c59fe7 url=https://127.0.0.1:47713/collection1
node=127.0.0.1:47713_ C6789_STATE=coll:control_collection core:collection1
props:{core=collection1, base_url=https://127.0.0.1:47713,
node_name=127.0.0.1:47713_, state=down}
[junit4] 2> 3547441 T10256 C6789 P47713 oasc.SyncStrategy.sync Sync
replicas to https://127.0.0.1:47713/collection1/
[junit4] 2> 3547441 T10219
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 3547441 T10256 C6789 P47713 oasc.SyncStrategy.syncReplicas
Sync Success - now sync replicas to me
[junit4] 2> 3547442 T10248 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> 3547442 T10256 C6789 P47713 oasc.SyncStrategy.syncToMe
https://127.0.0.1:47713/collection1/ has no replicas
[junit4] 2> 3547442 T10256
oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader:
https://127.0.0.1:47713/collection1/ shard1
[junit4] 2> 3547443 T10256 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/leaders/shard1
[junit4] 2> 3547443 T10219 oasc.ChaosMonkey.monkeyLog monkey: init -
expire sessions:false cause connection loss:false
[junit4] 2> 3547445 T10260 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 3547446 T10249 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":"https://127.0.0.1:47713";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 2
[junit4] 2> 3547548 T10259 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> 3547596 T10256 oasc.ZkController.register We are
https://127.0.0.1:47713/collection1/ and leader is
https://127.0.0.1:47713/collection1/
[junit4] 2> 3547597 T10256 oasc.ZkController.register No LogReplay needed
for core=collection1 baseURL=https://127.0.0.1:47713
[junit4] 2> 3547597 T10256 oasc.ZkController.checkRecovery I am the
leader, no recovery necessary
[junit4] 2> 3547597 T10256 oasc.ZkController.publish publishing
core=collection1 state=active collection=control_collection
[junit4] 2> 3547597 T10256 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 3547598 T10248 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 3547600 T10249 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "collection":"control_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"collection1",
[junit4] 2> "base_url":"https://127.0.0.1:47713";,
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:47713_",
[junit4] 2> "state":"active"} current state version: 3
[junit4] 2> 3547601 T10249 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "collection":"control_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"collection1",
[junit4] 2> "base_url":"https://127.0.0.1:47713";,
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:47713_",
[junit4] 2> "state":"active"}
[junit4] 2> 3547703 T10259 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> 3547703 T10248 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> 3547715 T10219 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1
[junit4] 2> 3547715 T10219 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3547718 T10219 oejus.SslContextFactory.doStart Enabled
Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3,
TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 3547719 T10219 oejs.AbstractConnector.doStart Started
[email protected]:33518
[junit4] 2> 3547721 T10219 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 3547721 T10219 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 3547722 T10219 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-003
[junit4] 2> 3547722 T10219 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-003/'
[junit4] 2> 3547739 T10219 oasc.ConfigSolr.fromFile Loading container
configuration from
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-003/solr.xml
[junit4] 2> 3547768 T10219 oasc.CoreContainer.<init> New CoreContainer
30514254
[junit4] 2> 3547769 T10219 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-003/]
[junit4] 2> 3547769 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 3547770 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 3547770 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 3547770 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 3547771 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 3547771 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 3547771 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 3547772 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 3547772 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 3547772 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 3547774 T10219 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 3547775 T10219 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3547775 T10219 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3547775 T10219 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3547776 T10219 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:33591/solr
[junit4] 2> 3547776 T10219 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 3547776 T10219
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3547777 T10219 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3547778 T10272 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1637560 name:ZooKeeperConnection
Watcher:127.0.0.1:33591 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 3547779 T10219 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3547779 T10219 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3547781 T10219 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3547781 T10275 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@158b10d name:ZooKeeperConnection
Watcher:127.0.0.1:33591/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 3547782 T10219 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3547786 T10219
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 3548789 T10219 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33518_
[junit4] 2> 3548790 T10219 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:33518_
[junit4] 2> 3548793 T10219 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 3548799 T10276 oasc.ZkController.publish publishing
core=collection1 state=down collection=collection1
[junit4] 2> 3548799 T10276 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 3548800 T10276 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 3548800 T10248 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 3548801 T10249 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "base_url":"https://127.0.0.1:33518";,
[junit4] 2> "roles":null,
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:33518_",
[junit4] 2> "state":"down"} current state version: 4
[junit4] 2> 3548802 T10249 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "base_url":"https://127.0.0.1:33518";,
[junit4] 2> "roles":null,
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:33518_",
[junit4] 2> "state":"down"}
[junit4] 2> 3548802 T10249 oasco.ClusterStateMutator.createCollection
building a new cName: collection1
[junit4] 2> 3548802 T10249 oasco.ReplicaMutator.updateState Assigning new
node to shard shard=shard2
[junit4] 2> 3548905 T10275 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> 3548905 T10248 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> 3548905 T10259 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> 3549800 T10276 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for collection1
[junit4] 2> 3549800 T10276 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:collection1
[junit4] 2> 3549801 T10276 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 3549801 T10276 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 3549802 T10276 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 3549803 T10276 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-003/collection1/'
[junit4] 2> 3549803 T10276 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-003/collection1/lib/.svn/'
to classloader
[junit4] 2> 3549804 T10276 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-003/collection1/lib/classes/'
to classloader
[junit4] 2> 3549804 T10276 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-003/collection1/lib/README'
to classloader
[junit4] 2> 3549826 T10276 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 3549828 T10276 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 3549854 T10276 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 3549906 T10276 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 3549907 T10276 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/managed-schema
[junit4] 2> 3549919 T10276 oass.IndexSchema.readSchema [collection1]
Schema name=test
[junit4] 2> 3550279 T10276 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3550285 T10276 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 3550288 T10276 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3550292 T10276 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3550296 T10276 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3550303 T10276 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3550303 T10276
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3550304 T10276
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3550304 T10276 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3550305 T10276
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3550305 T10276
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3550307 T10276 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection collection1
[junit4] 2> 3550308 T10276 oasc.SolrCore.initDirectoryFactory
solr.NRTCachingDirectoryFactory
[junit4] 2> 3550308 T10276 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-003/collection1/,
dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-003/collection1/data/
[junit4] 2> 3550309 T10276 oasc.SolrCore.<init> JMX monitoring not
detected for core: collection1
[junit4] 2> 3550309 T10276 oasc.CachingDirectoryFactory.get return new
directory for
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-003/collection1/data
[junit4] 2> 3550310 T10276 oasc.SolrCore.getNewIndexDir New index
directory detected: old=null
new=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-003/collection1/data/index/
[junit4] 2> 3550310 T10276 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-003/collection1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 3550311 T10276 oasc.CachingDirectoryFactory.get return new
directory for
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-003/collection1/data/index
[junit4] 2> 3550311 T10276 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=46, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=93.640625,
floorSegmentMB=1.021484375, forceMergeDeletesPctAllowed=9.546037337096186,
segmentsPerTier=50.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.14997496414427386
[junit4] 2> 3550321 T10276 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=NRTCachingDirectory(NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-003/collection1/data/index
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8ccf22;
maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 3550322 T10276 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 3550323 T10276 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3550323 T10276 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3550324 T10276 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3550324 T10276 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3550324 T10276 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3550325 T10276 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 3550325 T10276 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 3550325 T10276 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 3550326 T10276 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 3550326 T10276 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 3550327 T10276 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 3550327 T10276 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 3550327 T10276 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 3550328 T10276 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 3550328 T10276 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 3550328 T10276 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 3550329 T10276 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
[junit4] 2> 3550329 T10276 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 3550330 T10276 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 3550330 T10276 oasc.RequestHandlers.initHandlersFromConfig
created /dump: DumpRequestHandler
[junit4] 2> 3550334 T10276 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3550335 T10276 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3550337 T10276 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3550339 T10276 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3550339 T10276 oasc.RequestHandlers.applyInitParams WARN
INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class
= DumpRequestHandler,args = {defaults={a=A,b=B}}}
[junit4] 2> 3550341 T10276 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 3550342 T10276 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 3550342 T10276 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=33,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4889115969760214]
[junit4] 2> 3550343 T10276 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=NRTCachingDirectory(NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-003/collection1/data/index
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8ccf22;
maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 3550344 T10276 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 3550344 T10276 oass.SolrIndexSearcher.<init> Opening
Searcher@1185cf8[collection1] main
[junit4] 2> 3550344 T10276 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 3550345 T10276 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 3550345 T10276 oasr.ManagedResourceStorage.newStorageIO
Setting up ZooKeeper-based storage for the RestManager with znodeBase:
/configs/conf1
[junit4] 2> 3550346 T10276
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 3550346 T10276 oasr.RestManager.init Initializing RestManager
with initArgs: {}
[junit4] 2> 3550346 T10276 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 3550347 T10276
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream Read 38 bytes
from znode /configs/conf1/_rest_managed.json
[junit4] 2> 3550347 T10276 oasr.ManagedResourceStorage.load Loaded
LinkedHashMap at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 3550348 T10276 oasr.ManagedResource.reloadFromStorage Loaded
initArgs {} for /rest/managed
[junit4] 2> 3550348 T10276 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 3550348 T10276 oass.ZkIndexSchemaReader.createSchemaWatcher
Creating ZooKeeper watch for the managed schema at /configs/conf1/managed-schema
[junit4] 2> 3550349 T10276 oash.ReplicationHandler.inform Commits will be
reserved for 10000
[junit4] 2> 3550349 T10277 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@1185cf8[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 3550349 T10276 oasc.CoreContainer.registerCore registering
core: collection1
[junit4] 2> 3550350 T10280 oasc.ZkController.register Register replica -
core:collection1 address:https://127.0.0.1:33518 collection:collection1
shard:shard2
[junit4] 2> 3550352 T10219 oass.SolrDispatchFilter.init
user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0
[junit4] 2> 3550352 T10219 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 3550356 T10280 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leader_elect/shard2/election
[junit4] 2> 3550359 T10280
oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for
shard shard2
[junit4] 2> 3550360 T10248 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 3550361 T10280
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 3550362 T10280
oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try
and sync
[junit4] 2> 3550361 T10249 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"collection1"} current state version: 5
[junit4] 2> ASYNC NEW_CORE C6790 name=collection1
org.apache.solr.core.SolrCore@706eb5 url=https://127.0.0.1:33518/collection1
node=127.0.0.1:33518_ C6790_STATE=coll:collection1 core:collection1
props:{core=collection1, base_url=https://127.0.0.1:33518,
node_name=127.0.0.1:33518_, state=down}
[junit4] 2> 3550362 T10280 C6790 P33518 oasc.SyncStrategy.sync Sync
replicas to https://127.0.0.1:33518/collection1/
[junit4] 2> 3550362 T10280 C6790 P33518 oasc.SyncStrategy.syncReplicas
Sync Success - now sync replicas to me
[junit4] 2> 3550363 T10280 C6790 P33518 oasc.SyncStrategy.syncToMe
https://127.0.0.1:33518/collection1/ has no replicas
[junit4] 2> 3550363 T10280
oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader:
https://127.0.0.1:33518/collection1/ shard2
[junit4] 2> 3550363 T10280 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leaders/shard2
[junit4] 2> 3550366 T10248 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 3550366 T10249 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "base_url":"https://127.0.0.1:33518";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 5
[junit4] 2> 3550469 T10248 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> 3550469 T10275 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> 3550469 T10259 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> 3550517 T10280 oasc.ZkController.register We are
https://127.0.0.1:33518/collection1/ and leader is
https://127.0.0.1:33518/collection1/
[junit4] 2> 3550517 T10280 oasc.ZkController.register No LogReplay needed
for core=collection1 baseURL=https://127.0.0.1:33518
[junit4] 2> 3550517 T10280 oasc.ZkController.checkRecovery I am the
leader, no recovery necessary
[junit4] 2> 3550517 T10280 oasc.ZkController.publish publishing
core=collection1 state=active collection=collection1
[junit4] 2> 3550518 T10280 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 3550519 T10248 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 3550520 T10249 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"collection1",
[junit4] 2> "base_url":"https://127.0.0.1:33518";,
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:33518_",
[junit4] 2> "state":"active"} current state version: 6
[junit4] 2> 3550521 T10249 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"collection1",
[junit4] 2> "base_url":"https://127.0.0.1:33518";,
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:33518_",
[junit4] 2> "state":"active"}
[junit4] 2> 3550623 T10259 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> 3550623 T10275 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> 3550623 T10248 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> 3550738 T10219 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2
[junit4] 2> 3550739 T10219 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3550742 T10219 oejus.SslContextFactory.doStart Enabled
Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3,
TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 3550743 T10219 oejs.AbstractConnector.doStart Started
[email protected]:47897
[junit4] 2> 3550745 T10219 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 3550745 T10219 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 3550746 T10219 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-004
[junit4] 2> 3550746 T10219 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-004/'
[junit4] 2> 3550764 T10219 oasc.ConfigSolr.fromFile Loading container
configuration from
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-004/solr.xml
[junit4] 2> 3550796 T10219 oasc.CoreContainer.<init> New CoreContainer
24401235
[junit4] 2> 3550796 T10219 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-004/]
[junit4] 2> 3550797 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 3550798 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 3550798 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 3550798 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 3550799 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 3550799 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 3550800 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 3550800 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 3550800 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 3550801 T10219 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 3550802 T10219 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 3550803 T10219 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3550803 T10219 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3550804 T10219 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3550804 T10219 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:33591/solr
[junit4] 2> 3550804 T10219 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 3550805 T10219
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3550806 T10219 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3550807 T10292 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1f4d278 name:ZooKeeperConnection
Watcher:127.0.0.1:33591 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 3550807 T10219 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3550808 T10219 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3550809 T10219 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 3550810 T10295 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1cc1567 name:ZooKeeperConnection
Watcher:127.0.0.1:33591/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 3550810 T10219 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3550814 T10219
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 3551817 T10219 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:47897_
[junit4] 2> 3551818 T10219 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:47897_
[junit4] 2> 3551821 T10219 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 3551825 T10296 oasc.ZkController.publish publishing
core=collection1 state=down collection=collection1
[junit4] 2> 3551826 T10296 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 3551826 T10296 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 3551826 T10248 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 3551828 T10249 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "base_url":"https://127.0.0.1:47897";,
[junit4] 2> "roles":null,
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:47897_",
[junit4] 2> "state":"down"} current state version: 7
[junit4] 2> 3551828 T10249 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "base_url":"https://127.0.0.1:47897";,
[junit4] 2> "roles":null,
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:47897_",
[junit4] 2> "state":"down"}
[junit4] 2> 3551829 T10249 oasco.ReplicaMutator.updateState Collection
already exists with numShards=2
[junit4] 2> 3551829 T10249 oasco.ReplicaMutator.updateState Assigning new
node to shard shard=shard1
[junit4] 2> 3551931 T10275 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> 3551931 T10295 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> 3551931 T10248 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> 3551931 T10259 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> 3552827 T10296 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for collection1
[junit4] 2> 3552827 T10296 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:collection1
[junit4] 2> 3552828 T10296 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 3552828 T10296 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 3552829 T10296 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 3552829 T10296 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-004/collection1/'
[junit4] 2> 3552830 T10296 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-004/collection1/lib/.svn/'
to classloader
[junit4] 2> 3552831 T10296 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-004/collection1/lib/classes/'
to classloader
[junit4] 2> 3552831 T10296 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-004/collection1/lib/README'
to classloader
[junit4] 2> 3552847 T10296 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 3552850 T10296 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 3552868 T10296 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 3552896 T10296 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 3552897 T10296 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/managed-schema
[junit4] 2> 3552905 T10296 oass.IndexSchema.readSchema [collection1]
Schema name=test
[junit4] 2> 3553155 T10296 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3553160 T10296 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 3553162 T10296 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3553166 T10296 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3553169 T10296 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3553175 T10296 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3553176 T10296
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3553176 T10296
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3553177 T10296 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3553177 T10296
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3553178 T10296
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3553179 T10296 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection collection1
[junit4] 2> 3553180 T10296 oasc.SolrCore.initDirectoryFactory
solr.NRTCachingDirectoryFactory
[junit4] 2> 3553180 T10296 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-004/collection1/,
dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-004/collection1/data/
[junit4] 2> 3553180 T10296 oasc.SolrCore.<init> JMX monitoring not
detected for core: collection1
[junit4] 2> 3553181 T10296 oasc.CachingDirectoryFactory.get return new
directory for
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-004/collection1/data
[junit4] 2> 3553181 T10296 oasc.SolrCore.getNewIndexDir New index
directory detected: old=null
new=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-004/collection1/data/index/
[junit4] 2> 3553181 T10296 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-004/collection1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 3553182 T10296 oasc.CachingDirectoryFactory.get return new
directory for
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-004/collection1/data/index
[junit4] 2> 3553183 T10296 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=46, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=93.640625,
floorSegmentMB=1.021484375, forceMergeDeletesPctAllowed=9.546037337096186,
segmentsPerTier=50.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.14997496414427386
[junit4] 2> 3553190 T10296 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=NRTCachingDirectory(NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-004/collection1/data/index
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8746a6;
maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 3553190 T10296 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 3553192 T10296 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3553192 T10296 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3553192 T10296 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3553193 T10296 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3553193 T10296 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3553193 T10296 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 3553193 T10296 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 3553194 T10296 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 3553194 T10296 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 3553195 T10296 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 3553195 T10296 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 3553196 T10296 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 3553196 T10296 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 3553196 T10296 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 3553196 T10296 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 3553197 T10296 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 3553197 T10296 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
[junit4] 2> 3553197 T10296 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 3553198 T10296 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 3553198 T10296 oasc.RequestHandlers.initHandlersFromConfig
created /dump: DumpRequestHandler
[junit4] 2> 3553200 T10296 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3553201 T10296 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3553202 T10296 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3553204 T10296 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3553204 T10296 oasc.RequestHandlers.applyInitParams WARN
INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class
= DumpRequestHandler,args = {defaults={a=A,b=B}}}
[junit4] 2> 3553206 T10296 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 3553206 T10296 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 3553206 T10296 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=33,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4889115969760214]
[junit4] 2> 3553207 T10296 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=NRTCachingDirectory(NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-004/collection1/data/index
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8746a6;
maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 3553207 T10296 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 3553208 T10296 oass.SolrIndexSearcher.<init> Opening
Searcher@14bf056[collection1] main
[junit4] 2> 3553208 T10296 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 3553209 T10296 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 3553209 T10296 oasr.ManagedResourceStorage.newStorageIO
Setting up ZooKeeper-based storage for the RestManager with znodeBase:
/configs/conf1
[junit4] 2> 3553210 T10296
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 3553210 T10296 oasr.RestManager.init Initializing RestManager
with initArgs: {}
[junit4] 2> 3553210 T10296 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 3553211 T10296
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream Read 38 bytes
from znode /configs/conf1/_rest_managed.json
[junit4] 2> 3553211 T10296 oasr.ManagedResourceStorage.load Loaded
LinkedHashMap at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 3553211 T10296 oasr.ManagedResource.reloadFromStorage Loaded
initArgs {} for /rest/managed
[junit4] 2> 3553212 T10296 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 3553212 T10296 oass.ZkIndexSchemaReader.createSchemaWatcher
Creating ZooKeeper watch for the managed schema at /configs/conf1/managed-schema
[junit4] 2> 3553212 T10296 oash.ReplicationHandler.inform Commits will be
reserved for 10000
[junit4] 2> 3553213 T10297 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@14bf056[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 3553213 T10296 oasc.CoreContainer.registerCore registering
core: collection1
[junit4] 2> 3553214 T10300 oasc.ZkController.register Register replica -
core:collection1 address:https://127.0.0.1:47897 collection:collection1
shard:shard1
[junit4] 2> 3553214 T10219 oass.SolrDispatchFilter.init
user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0
[junit4] 2> 3553214 T10219 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 3553220 T10300 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leader_elect/shard1/election
[junit4] 2> 3553223 T10300
oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for
shard shard1
[junit4] 2> 3553224 T10248 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 3553224 T10300
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 3553224 T10300
oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try
and sync
[junit4] 2> ASYNC NEW_CORE C6791 name=collection1
org.apache.solr.core.SolrCore@44fb33 url=https://127.0.0.1:47897/collection1
node=127.0.0.1:47897_ C6791_STATE=coll:
[...truncated too long message...]
actory.close Closing directory:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001/tempDir-006/collection1/data/index
[junit4] 2> 3588024 T10219 oasc.Overseer.close Overseer
(id=93001064867758093-127.0.0.1:34796_-n_0000000004) closing
[junit4] 2> 3588024 T10407 oasc.Overseer$ClusterStateUpdater.run Overseer
Loop exiting : 127.0.0.1:34796_
[junit4] 2> 3589524 T10337 oascc.ZkStateReader$2.process WARN ZooKeeper
watch triggered, but Solr cannot talk to ZK
[junit4] 2> 3589524 T10353 oascc.ZkStateReader$3.process WARN ZooKeeper
watch triggered, but Solr cannot talk to ZK
[junit4] 2> 3589548 T10219 oejsh.ContextHandler.doStop stopped
o.e.j.s.ServletContextHandler{/,null}
[junit4] 2> 3594538 T10219 oas.SolrTestCaseJ4.tearDown ###Ending
testDistribSearch
[junit4] 2> 3594540 T10219 oasc.ZkTestServer.send4LetterWord connecting to
127.0.0.1:33591 33591
[junit4] 2> 3595132 T10220 oasc.ZkTestServer.send4LetterWord connecting to
127.0.0.1:33591 33591
[junit4] 2> 3595133 T10220 oasc.ZkTestServer$ZKServerMain.runFromConfig
WARN Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 30 /solr/configs/conf1
[junit4] 2> 9 /solr/configs/conf1/managed-schema
[junit4] 2> 6 /solr/aliases.json
[junit4] 2> 6 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 6 /solr/configs/conf1/managed-schema
[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=TestBulkSchemaConcurrent -Dtests.method=testDistribSearch
-Dtests.seed=58D29EBE8B2EC667 -Dtests.multiplier=3 -Dtests.slow=true
-Dtests.locale=is_IS -Dtests.timezone=America/Recife -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] ERROR 49.8s J0 | TestBulkSchemaConcurrent.testDistribSearch <<<
[junit4] > Throwable #1: java.lang.NullPointerException
[junit4] > at
__randomizedtesting.SeedInfo.seed([58D29EBE8B2EC667:D93410A6FC71A65B]:0)
[junit4] > at
org.apache.solr.schema.TestBulkSchemaConcurrent.doTest(TestBulkSchemaConcurrent.java:108)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 3595140 T10219 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/J0/temp/solr.schema.TestBulkSchemaConcurrent-58D29EBE8B2EC667-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {},
docValues:{}, sim=DefaultSimilarity, locale=is_IS, timezone=America/Recife
[junit4] 2> NOTE: Linux 3.13.0-43-generic i386/Oracle Corporation 1.7.0_67
(32-bit)/cpus=8,threads=1,free=172859624,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [ShowFileRequestHandlerTest,
TestIndexingPerformance, TestOmitPositions, PluginInfoTest,
TestSweetSpotSimilarityFactory, TestSolrDeletionPolicy2, RecoveryZkTest,
PrimUtilsTest, AnalyticsQueryTest, CollectionsAPIAsyncDistributedZkTest,
TestNonNRTOpen, DocValuesTest, TestDynamicFieldCollectionResource,
SolrIndexSplitterTest, FieldAnalysisRequestHandlerTest,
DirectUpdateHandlerTest, TestXIncludeConfig, NumericFieldsTest,
SolrXmlInZkTest, ShardRoutingTest, AnalysisAfterCoreReloadTest,
LukeRequestHandlerTest, TestSchemaNameResource, SimpleFacetsTest,
TestSchemaSimilarityResource, TestLMDirichletSimilarityFactory,
TestRecoveryHdfs, SyncSliceTest, DistributedFacetPivotSmallAdvancedTest,
AliasIntegrationTest, TestCloudManagedSchema, AssignTest,
TestWordDelimiterFilterFactory, TestMiniSolrCloudCluster,
TestFuzzyAnalyzedSuggestions, TestDistributedMissingSort,
TestDFRSimilarityFactory, TestRandomMergePolicy, TestReRankQParserPlugin,
TestSearcherReuse, TestSolrXmlPersistence, TestPhraseSuggestions,
DistanceFunctionTest, DocValuesMissingTest, TestQueryTypes, RankQueryTest,
HardAutoCommitTest, BlockCacheTest, TestRequestStatusCollectionAPI,
UUIDFieldTest, TestFastOutputStream, TestCursorMarkWithoutUniqueKey,
TestConfigReload, RemoteQueryErrorTest, TestFileDictionaryLookup, TestSort,
ZkControllerTest, PreAnalyzedFieldTest, CachingDirectoryFactoryTest,
UnloadDistributedZkTest, TestComponentsName, AlternateDirectoryTest,
QueryElevationComponentTest, TestReplicationHandler, TestLazyCores,
HdfsLockFactoryTest, TestOrdValues, TestCollationFieldDocValues,
SuggesterFSTTest, UniqFieldsUpdateProcessorFactoryTest, MultiTermTest,
BadCopyFieldTest, TestBinaryResponseWriter, MergeStrategyTest,
DistributedQueryComponentCustomSortTest, TestBulkSchemaAPI, CircularListTest,
TestSolrConfigHandlerCloud, TestPartialUpdateDeduplication, ClusterStateTest,
RequiredFieldsTest, SystemInfoHandlerTest, DefaultValueUpdateProcessorTest,
TestUpdate, UUIDUpdateProcessorFallbackTest, DeleteShardTest,
DistribCursorPagingTest, CursorPagingTest, TestShardHandlerFactory,
SortByFunctionTest, ParsingFieldUpdateProcessorsTest,
TestManagedSchemaFieldTypeResource, TestLRUCache, TestAnalyzedSuggestions,
TestManagedSynonymFilterFactory, AtomicUpdatesTest, TestAtomicUpdateErrorCases,
TestIndexSearcher, NoCacheHeaderTest, CoreAdminRequestStatusTest, SolrCoreTest,
OverseerStatusTest, DistributedSuggestComponentTest, TestBinaryField,
TestCustomSort, TestSurroundQueryParser, TestQuerySenderNoQuery,
XmlUpdateRequestHandlerTest, TestModifyConfFiles, ClusterStateUpdateTest,
OpenCloseCoreStressTest, OverseerTest, LeaderElectionIntegrationTest,
TestRandomFaceting, LeaderElectionTest, TestZkChroot, TestRandomDVFaceting,
TestDistributedGrouping, TestHashPartitioner,
TermVectorComponentDistributedTest, TestJoin, DistributedTermsComponentTest,
PeerSyncTest, TestFunctionQuery, TestBadConfig, SoftAutoCommitTest,
DistributedQueryElevationComponentTest, WordBreakSolrSpellCheckerTest,
TestPseudoReturnFields, FieldMutatingUpdateProcessorTest, DocValuesMultiTest,
TestSolrDeletionPolicy1, SolrInfoMBeanTest, XsltUpdateRequestHandlerTest,
CacheHeaderTest, DocumentAnalysisRequestHandlerTest, TermsComponentTest,
TermVectorComponentTest, TestArbitraryIndexDir, SolrPluginUtilsTest,
TestCollationField, ReturnFieldsTest, JSONWriterTest, PingRequestHandlerTest,
CoreContainerCoreInitFailuresTest, TestQuerySenderListener,
SolrIndexConfigTest, TestStressRecovery, TestLuceneMatchVersion,
SynonymTokenizerTest, TestPerFieldSimilarity, TestBM25SimilarityFactory,
LegacyHTMLStripCharFilterTest, ResourceLoaderTest,
OpenExchangeRatesOrgProviderTest, URLClassifyProcessorTest,
ChaosMonkeyNothingIsSafeTest, TestHighlightDedupGrouping, TestTolerantSearch,
ConnectionManagerTest, CustomCollectionTest, DistributedQueueTest,
ExternalCollectionsTest, HttpPartitionTest,
LeaderInitiatedRecoveryOnCommitTest, OutOfBoxZkACLAndCredentialsProvidersTest,
OverriddenZkACLAndCredentialsProvidersTest, OverseerRolesTest,
RollingRestartTest, SharedFSAutoReplicaFailoverTest,
SharedFSAutoReplicaFailoverUtilsTest, TestCloudInspectUtil,
TestCloudPivotFacet, TestCollectionAPI, TestDistribDocBasedVersion,
TestLeaderElectionZkExpiry, TriLevelCompositeIdRoutingTest,
VMParamsZkACLAndCredentialsProvidersTest, HdfsChaosMonkeySafeLeaderTest,
HdfsRecoveryZkTest, HdfsSyncSliceTest, HdfsUnloadDistributedZkTest,
StressHdfsTest, TestClusterStateMutator, ZkStateWriterTest,
ExitableDirectoryReaderTest, QueryResultKeyTest, TestConfigOverlay,
TestConfigSets, TestImplicitCoreProperties, TestInfoStreamLogging, TestNRTOpen,
TestReloadAndDeleteDocs, TestSolrConfigHandler, DistributedExpandComponentTest,
DistributedQueryComponentOptimizationTest, TestChildDocTransformer,
TestRawResponseWriter, TestSortingResponseWriter, TestManagedResource,
TestRestManager, TestClassNameShortening, TestCopyFieldCollectionResource,
TestFieldCollectionResource, TestFieldTypeCollectionResource,
TestFieldTypeResource, TestManagedSchemaDynamicFieldResource,
TestSchemaResource, TestSerializedLuceneMatchVersion,
TestSolrQueryParserDefaultOperatorResource, TestUniqueKeyFieldResource,
TestManagedStopFilterFactory, DateRangeFieldTest, EnumFieldTest,
ModifyConfFileTest, TestBulkSchemaConcurrent]
[junit4] Completed on J0 in 49.79s, 1 test, 1 error <<< FAILURES!
[...truncated 88 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:190: 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: 452 suites, 1852 tests, 1 error, 47 ignored (22
assumptions)
Total time: 102 minutes 37 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 32bit/jdk1.7.0_67 -client
-XX:+UseConcMarkSweepGC (asserts: true)
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
