Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Windows/4398/
Java: 64bit/jdk1.8.0_40-ea-b09 -XX:-UseCompressedOops -XX:+UseSerialGC
(asserts: true)
2 tests failed.
FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testDistribSearch
Error Message:
Test abandoned because suite timeout was reached.
Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
at __randomizedtesting.SeedInfo.seed([95E8142F369C3425]:0)
FAILED:
junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest
Error Message:
Suite timeout exceeded (>= 7200000 msec).
Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
at __randomizedtesting.SeedInfo.seed([95E8142F369C3425]:0)
Build Log:
[...truncated 9546 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\init-core-data-001
[junit4] 2> 1629779 T4435 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(true) and clientAuth (false)
[junit4] 2> 1629779 T4435
oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system
property: /
[junit4] 2> 1629783 T4435 oas.SolrTestCaseJ4.setUp ###Starting
testDistribSearch
[junit4] 2> 1629783 T4435 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1629785 T4436 oasc.ZkTestServer$ZKServerMain.runFromConfig
Starting server
[junit4] 2> 1629880 T4435 oasc.ZkTestServer.run start zk server on
port:51124
[junit4] 2> 1629880 T4435
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1629881 T4435 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1629890 T4443 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@3440f24c
name:ZooKeeperConnection Watcher:127.0.0.1:51124 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1629890 T4435 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1629890 T4435 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1629890 T4435 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 1629898 T4435
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1629899 T4435 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1629901 T4446 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@28b60ae2
name:ZooKeeperConnection Watcher:127.0.0.1:51124/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1629901 T4435 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1629901 T4435 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1629901 T4435 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 1629905 T4435 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 1629908 T4435 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 1629910 T4435 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 1629912 T4435 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 1629912 T4435 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 1629917 T4435 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 1629917 T4435 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 1629922 T4435 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1629922 T4435 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1629924 T4435 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 1629924 T4435 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 1629928 T4435 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 1629928 T4435 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 1629932 T4435 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 1629932 T4435 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 1629935 T4435 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 1629935 T4435 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 1629937 T4435 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 1629938 T4435 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 1629941 T4435 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1629941 T4435 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1629944 T4435 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 1629944 T4435 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 1629948 T4435 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 1629948 T4435 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> 1629951 T4435
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1629953 T4435 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1629958 T4449 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@24e0dc65
name:ZooKeeperConnection Watcher:127.0.0.1:51124/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1629958 T4435 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1629958 T4435 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> Using new style solr.xml
[junit4] 2> 1631295 T4435 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1631302 T4435 oejus.SslContextFactory.doStart Enabled
Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3,
TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 1631306 T4435 oejs.AbstractConnector.doStart Started
[email protected]:51134
[junit4] 2> 1631308 T4435 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 1631308 T4435 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 1631308 T4435 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-002
[junit4] 2> 1631308 T4435 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-002\'
[junit4] 2> 1631335 T4435 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-002\solr.xml
[junit4] 2> 1631358 T4435 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-002
[junit4] 2> 1631359 T4435 oasc.CoreContainer.<init> New CoreContainer
1734060986
[junit4] 2> 1631359 T4435 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-002\]
[junit4] 2> 1631360 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 1631360 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 1631360 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 1631360 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 1631361 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 1631361 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 1631361 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 1631362 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 1631362 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 1631362 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 1631365 T4435 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 1631368 T4435 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1631368 T4435 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1631368 T4435 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 1631368 T4435 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:51124/solr
[junit4] 2> 1631368 T4435 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 1631368 T4435
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1631371 T4435 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1631374 T4461 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@77065c4b
name:ZooKeeperConnection Watcher:127.0.0.1:51124 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1631375 T4435 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1631375 T4435 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1631379 T4435 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1631380 T4464 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@6bc3ae74
name:ZooKeeperConnection Watcher:127.0.0.1:51124/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1631381 T4435 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1631382 T4435 oascc.SolrZkClient.makePath makePath:
/overseer/queue
[junit4] 2> 1631386 T4435 oascc.SolrZkClient.makePath makePath:
/overseer/collection-queue-work
[junit4] 2> 1631390 T4435 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-running
[junit4] 2> 1631393 T4435 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-completed
[junit4] 2> 1631397 T4435 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-failure
[junit4] 2> 1631402 T4435 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 1631404 T4435 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:51134_
[junit4] 2> 1631405 T4435 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:51134_
[junit4] 2> 1631408 T4435 oascc.SolrZkClient.makePath makePath:
/overseer_elect
[junit4] 2> 1631410 T4435 oascc.SolrZkClient.makePath makePath:
/overseer_elect/election
[junit4] 2> 1631413 T4435 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 1631415 T4435 oasc.OverseerElectionContext.runLeaderProcess I
am going to be the leader 127.0.0.1:51134_
[junit4] 2> 1631416 T4435 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 1631417 T4435 oasc.Overseer.start Overseer
(id=93003118511259652-127.0.0.1:51134_-n_0000000000) starting
[junit4] 2> 1631420 T4435 oascc.SolrZkClient.makePath makePath:
/overseer/queue-work
[junit4] 2> 1631431 T4435 oasc.OverseerAutoReplicaFailoverThread.<init>
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=10000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 1631432 T4466 oasc.OverseerCollectionProcessor.run Process
current queue of collection creations
[junit4] 2> 1631434 T4435 oascc.SolrZkClient.makePath makePath:
/clusterstate.json
[junit4] 2> 1631437 T4435 oascc.SolrZkClient.makePath makePath:
/aliases.json
[junit4] 2> 1631439 T4435
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1631443 T4465 oasc.Overseer$ClusterStateUpdater.run Starting
to work on the main queue
[junit4] 2> 1631444 T4435 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-002
[junit4] 2> 1632476 T4435 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-002\conf\
[junit4] 2> 1632671 T4435 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 1632673 T4435 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 1632673 T4435 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 1632681 T4435
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1632682 T4435 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1632684 T4471 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@18a0fa2f
name:ZooKeeperConnection Watcher:127.0.0.1:51124/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1632685 T4435 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1632685 T4435 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1632687 T4435
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1632691 T4435 oasc.ChaosMonkey.monkeyLog monkey: init - expire
sessions:false cause connection loss:false
[junit4] 2> 1632692 T4435 oasc.AbstractFullDistribZkTestBase.createJettys
Creating collection1 with stateFormat=2
[junit4] 2> 1632692 T4435
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1632693 T4435 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1632695 T4474 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@7dae960c
name:ZooKeeperConnection Watcher:127.0.0.1:51124/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1632695 T4435 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1632696 T4435 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1632698 T4464 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1632704 T4465 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 0, message = {
[junit4] 2> "operation":"create",
[junit4] 2> "name":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "stateFormat":2} current state version: 0
[junit4] 2> 1632705 T4465 oasco.ClusterStateMutator.createCollection
building a new cName: collection1
[junit4] 2> 1632706 T4465 oasco.ZkStateWriter.writePendingUpdates going to
create_collection /collections/collection1/state.json
[junit4] 2> 1632708 T4464 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> 1632708 T4471 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> 1633998 T4435 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1
[junit4] 2> 1633999 T4435 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1634004 T4435 oejus.SslContextFactory.doStart Enabled
Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3,
TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 1634006 T4435 oejs.AbstractConnector.doStart Started
[email protected]:51149
[junit4] 2> 1634009 T4435 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 1634009 T4435 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 1634009 T4435 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-003
[junit4] 2> 1634009 T4435 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-003\'
[junit4] 2> 1634033 T4435 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-003\solr.xml
[junit4] 2> 1634042 T4435 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-003
[junit4] 2> 1634042 T4435 oasc.CoreContainer.<init> New CoreContainer
690147314
[junit4] 2> 1634042 T4435 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-003\]
[junit4] 2> 1634044 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 1634044 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 1634044 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 1634044 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 1634044 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 1634044 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 1634044 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 1634044 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 1634045 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 1634045 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 1634048 T4435 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 1634050 T4435 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1634050 T4435 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1634050 T4435 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 1634050 T4435 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:51124/solr
[junit4] 2> 1634050 T4435 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 1634050 T4435
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1634053 T4435 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1634055 T4486 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5c77cdc7
name:ZooKeeperConnection Watcher:127.0.0.1:51124 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1634056 T4435 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1634056 T4435 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1634058 T4437 oazs.NIOServerCnxn.doIO WARN caught end of
stream exception EndOfStreamException: Unable to read additional data from
client sessionid 0x14a69d7f1de0007, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 1634058 T4435 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1634060 T4489 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@6df87f70
name:ZooKeeperConnection Watcher:127.0.0.1:51124/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1634060 T4435 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1634068 T4435
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1634927 T4435 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:51149_
[junit4] 2> 1634928 T4435 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:51149_
[junit4] 2> 1634934 T4435 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 1634938 T4435 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-003
[junit4] 2> 1635868 T4435 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-003\conf\
[junit4] 2> 1636032 T4435 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 1636035 T4435 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 1636035 T4435 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 1637315 T4435 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2
[junit4] 2> 1637315 T4435 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1637324 T4435 oejus.SslContextFactory.doStart Enabled
Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3,
TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 1637325 T4435 oejs.AbstractConnector.doStart Started
[email protected]:51158
[junit4] 2> 1637328 T4435 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 1637328 T4435 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 1637328 T4435 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-004
[junit4] 2> 1637330 T4435 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-004\'
[junit4] 2> 1637359 T4435 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-004\solr.xml
[junit4] 2> 1637369 T4435 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-004
[junit4] 2> 1637370 T4435 oasc.CoreContainer.<init> New CoreContainer
612615614
[junit4] 2> 1637370 T4435 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-004\]
[junit4] 2> 1637370 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 1637370 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 1637370 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 1637370 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 1637371 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 1637371 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 1637371 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 1637371 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 1637372 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 1637372 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 1637375 T4435 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 1637377 T4435 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1637378 T4435 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1637378 T4435 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 1637378 T4435 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:51124/solr
[junit4] 2> 1637379 T4435 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 1637379 T4435
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1637380 T4435 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1637382 T4502 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@7e442d68
name:ZooKeeperConnection Watcher:127.0.0.1:51124 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1637383 T4435 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1637383 T4435 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1637386 T4435 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1637388 T4505 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5d3f11c5
name:ZooKeeperConnection Watcher:127.0.0.1:51124/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1637388 T4435 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1637396 T4435
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1638255 T4435 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:51158_
[junit4] 2> 1638256 T4435 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:51158_
[junit4] 2> 1638262 T4435 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 1638265 T4435 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-004
[junit4] 2> 1639188 T4435 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-004\conf\
[junit4] 2> 1639354 T4435 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 1639355 T4435 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 1639356 T4435 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 1640611 T4435 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 3
[junit4] 2> 1640612 T4435 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1640620 T4435 oejus.SslContextFactory.doStart Enabled
Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3,
TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 1640622 T4435 oejs.AbstractConnector.doStart Started
[email protected]:51167
[junit4] 2> 1640625 T4435 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 1640626 T4435 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 1640626 T4435 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-005
[junit4] 2> 1640626 T4435 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-005\'
[junit4] 2> 1640676 T4435 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-005\solr.xml
[junit4] 2> 1640684 T4435 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-005
[junit4] 2> 1640686 T4435 oasc.CoreContainer.<init> New CoreContainer
920624700
[junit4] 2> 1640686 T4435 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-005\]
[junit4] 2> 1640687 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 1640687 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 1640687 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 1640687 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 1640687 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 1640688 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 1640688 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 1640688 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 1640688 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 1640688 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 1640691 T4435 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 1640694 T4435 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1640694 T4435 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1640695 T4435 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 1640695 T4435 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:51124/solr
[junit4] 2> 1640695 T4435 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 1640696 T4435
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1640696 T4435 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1640698 T4520 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5b5dbf52
name:ZooKeeperConnection Watcher:127.0.0.1:51124 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1640699 T4435 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1640699 T4435 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1640701 T4437 oazs.NIOServerCnxn.doIO WARN caught end of
stream exception EndOfStreamException: Unable to read additional data from
client sessionid 0x14a69d7f1de000b, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 1640701 T4435 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1640703 T4523 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@29190702
name:ZooKeeperConnection Watcher:127.0.0.1:51124/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1640703 T4435 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1640711 T4435
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1641569 T4435 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:51167_
[junit4] 2> 1641570 T4435 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:51167_
[junit4] 2> 1641576 T4435 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 1641580 T4435 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-005
[junit4] 2> 1642480 T4435 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-005\conf\
[junit4] 2> 1642628 T4435 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 1642629 T4435 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 1642629 T4435 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 1643753 T4435 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 4
[junit4] 2> 1643754 T4435 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1643762 T4435 oejus.SslContextFactory.doStart Enabled
Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3,
TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 1643765 T4435 oejs.AbstractConnector.doStart Started
[email protected]:51176
[junit4] 2> 1643770 T4435 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 1643770 T4435 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 1643770 T4435 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-006
[junit4] 2> 1643771 T4435 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-006\'
[junit4] 2> 1643817 T4435 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-006\solr.xml
[junit4] 2> 1643823 T4435 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-006
[junit4] 2> 1643825 T4435 oasc.CoreContainer.<init> New CoreContainer
1520483139
[junit4] 2> 1643825 T4435 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-006\]
[junit4] 2> 1643826 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 1643826 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 1643826 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 1643827 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 1643827 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 1643827 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 1643827 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 1643827 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 1643827 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 1643827 T4435 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 1643831 T4435 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 1643833 T4435 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1643833 T4435 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1643833 T4435 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 1643834 T4435 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:51124/solr
[junit4] 2> 1643834 T4435 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 1643834 T4435
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1643836 T4435 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1643837 T4536 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@13c85a32
name:ZooKeeperConnection Watcher:127.0.0.1:51124 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1643839 T4435 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1643839 T4435 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1643841 T4435 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 1643842 T4539 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@6661085e
name:ZooKeeperConnection Watcher:127.0.0.1:51124/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1643843 T4435 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1643851 T4435
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1644625 T4435 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:51176_
[junit4] 2> 1644627 T4435 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:51176_
[junit4] 2> 1644633 T4435 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 1644636 T4435 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-006
[junit4] 2> 1645480 T4435 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-006\conf\
[junit4] 2> 1645627 T4435 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 1645629 T4435 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 1645630 T4435 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 1645660 T4480 oasha.CollectionsHandler.handleCreateAction
Creating Collection :
replicationFactor=2&collection.configName=conf1&router.field=myOwnField&name=solrj_collection&action=CREATE&numShards=2&wt=javabin&version=2
[junit4] 2> 1645661 T4464 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/collection-queue-work state
SyncConnected
[junit4] 2> 1645663 T4466 oasc.OverseerCollectionProcessor.run Overseer
Collection Processor: Get the message
id:/overseer/collection-queue-work/qn-0000000000 message:{
[junit4] 2> "operation":"create",
[junit4] 2> "fromApi":"true",
[junit4] 2> "name":"solrj_collection",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "collection.configName":"conf1",
[junit4] 2> "numShards":"2",
[junit4] 2> "router.field":"myOwnField"}
[junit4] 2> 1645664 T4541 oasc.OverseerCollectionProcessor.processMessage
WARN OverseerCollectionProcessor.processMessage : create , {
[junit4] 2> "operation":"create",
[junit4] 2> "fromApi":"true",
[junit4] 2> "name":"solrj_collection",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "collection.configName":"conf1",
[junit4] 2> "numShards":"2",
[junit4] 2> "router.field":"myOwnField"}
[junit4] 2> 1645667 T4541 oasc.OverseerCollectionProcessor.createConfNode
creating collections conf node /collections/solrj_collection
[junit4] 2> 1645669 T4541 oascc.SolrZkClient.makePath makePath:
/collections/solrj_collection
[junit4] 2> 1645674 T4464 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1645676 T4465 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"create",
[junit4] 2> "fromApi":"true",
[junit4] 2> "name":"solrj_collection",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "collection.configName":"conf1",
[junit4] 2> "numShards":"2",
[junit4] 2> "router.field":"myOwnField"} current state version: 1
[junit4] 2> 1645677 T4465 oasco.ClusterStateMutator.createCollection
building a new cName: solrj_collection
[junit4] 2> 1645680 T4523 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 1645680 T4464 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 1645680 T4471 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 1645681 T4489 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 1645681 T4539 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 1645681 T4505 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 1645828 T4541
oasc.OverseerCollectionProcessor.createCollection Creating SolrCores for new
collection solrj_collection, shardNames [shard1, shard2] , replicationFactor : 2
[junit4] 2> 1645828 T4541
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard1_replica1 as part of slice shard1 of collection
solrj_collection on 127.0.0.1:51149_
[junit4] 2> 1645829 T4541
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard1_replica2 as part of slice shard1 of collection
solrj_collection on 127.0.0.1:51176_
[junit4] 2> 1645834 T4541
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard2_replica1 as part of slice shard2 of collection
solrj_collection on 127.0.0.1:51158_
[junit4] 2> 1645842 T4541
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard2_replica2 as part of slice shard2 of collection
solrj_collection on 127.0.0.1:51134_
[junit4] 2> 1645865 T4482 oasha.CoreAdminHandler.handleCreateAction core
create command
qt=/admin/cores&collection.configName=conf1&name=solrj_collection_shard1_replica1&action=CREATE&numShards=2&collection=solrj_collection&shard=shard1&wt=javabin&version=2
[junit4] 2> 1645869 T4532 oasha.CoreAdminHandler.handleCreateAction core
create command
qt=/admin/cores&collection.configName=conf1&name=solrj_collection_shard1_replica2&action=CREATE&numShards=2&collection=solrj_collection&shard=shard1&wt=javabin&version=2
[junit4] 2> 1645901 T4482 oasc.ZkController.publish publishing
core=solrj_collection_shard1_replica1 state=down collection=solrj_collection
[junit4] 2> 1645901 T4498 oasha.CoreAdminHandler.handleCreateAction core
create command
qt=/admin/cores&collection.configName=conf1&name=solrj_collection_shard2_replica1&action=CREATE&numShards=2&collection=solrj_collection&shard=shard2&wt=javabin&version=2
[junit4] 2> 1645907 T4482 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 1645907 T4532 oasc.ZkController.publish publishing
core=solrj_collection_shard1_replica2 state=down collection=solrj_collection
[junit4] 2> 1645907 T4454 oasha.CoreAdminHandler.handleCreateAction core
create command
qt=/admin/cores&collection.configName=conf1&name=solrj_collection_shard2_replica2&action=CREATE&numShards=2&collection=solrj_collection&shard=shard2&wt=javabin&version=2
[junit4] 2> 1645909 T4464 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1645909 T4532 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 1645912 T4465 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 2, message = {
[junit4] 2> "core":"solrj_collection_shard1_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:51149";,
[junit4] 2> "node_name":"127.0.0.1:51149_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"} current state version: 2
[junit4] 2> 1645913 T4498 oasc.ZkController.publish publishing
core=solrj_collection_shard2_replica1 state=down collection=solrj_collection
[junit4] 2> 1645914 T4454 oasc.ZkController.publish publishing
core=solrj_collection_shard2_replica2 state=down collection=solrj_collection
[junit4] 2> 1645914 T4498 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 1645915 T4465 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "core":"solrj_collection_shard1_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:51149";,
[junit4] 2> "node_name":"127.0.0.1:51149_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 1645916 T4454 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 1645920 T4465 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 3, message = {
[junit4] 2> "core":"solrj_collection_shard1_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:51176";,
[junit4] 2> "node_name":"127.0.0.1:51176_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"} current state version: 2
[junit4] 2> 1645922 T4465 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "core":"solrj_collection_shard1_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:51176";,
[junit4] 2> "node_name":"127.0.0.1:51176_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 1645925 T4464 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1645927 T4465 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 3, message = {
[junit4] 2> "core":"solrj_collection_shard2_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:51158";,
[junit4] 2> "node_name":"127.0.0.1:51158_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"} current state version: 2
[junit4] 2> 1645929 T4465 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "core":"solrj_collection_shard2_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:51158";,
[junit4] 2> "node_name":"127.0.0.1:51158_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 1645934 T4465 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "core":"solrj_collection_shard2_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:51134";,
[junit4] 2> "node_name":"127.0.0.1:51134_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"} current state version: 2
[junit4] 2> 1645936 T4465 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "core":"solrj_collection_shard2_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:51134";,
[junit4] 2> "node_name":"127.0.0.1:51134_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 1645939 T4464 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 1646018 T4464 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 1646019 T4489 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 1646019 T4539 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 1646019 T4505 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 1646019 T4471 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 1646018 T4523 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 1646673 T4482 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard1_replica1
[junit4] 2> 1646673 T4482 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 1646674 T4482 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 1646674 T4482 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 1646675 T4532 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard1_replica2
[junit4] 2> 1646675 T4482 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 1646675 T4482 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-003\solrj_collection_shard1_replica1\'
[junit4] 2> 1646676 T4532 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 1646677 T4532 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 1646677 T4532 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 1646678 T4532 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 1646678 T4532 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-006\solrj_collection_shard1_replica2\'
[junit4] 2> 1646681 T4498 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard2_replica1
[junit4] 2> 1646681 T4498 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 1646683 T4454 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard2_replica2
[junit4] 2> 1646683 T4454 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 1646683 T4498 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 1646687 T4498 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 1646688 T4454 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 1646688 T4454 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 1646703 T4482 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 1646713 T4532 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 1646718 T4454 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 1646719 T4454 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-002\solrj_collection_shard2_replica2\'
[junit4] 2> 1646719 T4498 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 1646720 T4498 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-004\solrj_collection_shard2_replica1\'
[junit4] 2> 1646722 T4482 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 1646734 T4532 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 1646734 T4454 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 1646742 T4498 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 1646743 T4454 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 1646757 T4482 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 1646765 T4532 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 1646771 T4454 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 1646766 T4482 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 1646782 T4498 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 1646784 T4532 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 1646788 T4454 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 1646790 T4454 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 1646793 T4532 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 1646793 T4454 oass.IndexSchema.readSchema
[solrj_collection_shard2_replica2] Schema name=test
[junit4] 2> 1646795 T4532 oass.IndexSchema.readSchema
[solrj_collection_shard1_replica2] Schema name=test
[junit4] 2> 1646833 T4482 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 1646837 T4482 oass.IndexSchema.readSchema
[solrj_collection_shard1_replica1] Schema name=test
[junit4] 2> 1646880 T4498 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 1646920 T4498 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 1646945 T4454 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1646950 T4454 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 1646951 T4454 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1646977 T4532 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1646979 T4532 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 1646980 T4532 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1646984 T4498 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 1646987 T4498 oass.IndexSchema.readSchema
[solrj_collection_shard2_replica1] Schema name=test
[junit4] 2> 1646992 T4482 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1646995 T4482 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 1647003 T4482 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1647025 T4454 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1647028 T4454 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1647039 T4454 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1647042 T4454
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1647044 T4454
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1647044 T4454 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1647047 T4454
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1647047 T4454
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1647048 T4454 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard2_replica2' using configuration from collection
solrj_collection
[junit4] 2> 1647048 T4454 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1647048 T4454 oasc.SolrCore.<init>
[solrj_collection_shard2_replica2] Opening new SolrCore at
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-002\solrj_collection_shard2_replica2\,
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-002\solrj_collection_shard2_replica2\data\
[junit4] 2> 1647048 T4454 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3dad7f88
[junit4] 2> 1647049 T4454 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-002\solrj_collection_shard2_replica2\data\
[junit4] 2> 1647049 T4454 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-002\solrj_collection_shard2_replica2\data\index/
[junit4] 2> 1647049 T4454 oasc.SolrCore.initIndex WARN
[solrj_collection_shard2_replica2] Solr index directory
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-002\solrj_collection_shard2_replica2\data\index'
doesn't exist. Creating new index...
[junit4] 2> 1647050 T4454 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-002\solrj_collection_shard2_replica2\data\index
[junit4] 2> 1647050 T4454 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@7651c778
[junit4] 2> 1647052 T4454 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@6d7d7cfb
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1de117f6),segFN=segments_1,generation=1}
[junit4] 2> 1647052 T4454 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 1647055 T4454 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 1647055 T4454 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 1647055 T4454 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1647055 T4454 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 1647055 T4454 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1647055 T4454 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1647056 T4454 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1647056 T4454 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 1647056 T4454 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1647057 T4454 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1647057 T4454 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1647057 T4454 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1647058 T4454 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 1647058 T4454 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 1647058 T4454 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 1647059 T4454 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 1647059 T4454 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 1647059 T4454 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 1647061 T4532 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1647062 T4482 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1647065 T4532 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1647073 T4482 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 1647087 T4454 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 1647088 T4454 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 1647088 T4454 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 1647088 T4454 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 1647089 T4454 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 1647089 T4454 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 1647089 T4454 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 1647090 T4454 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 1647091 T4454 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 1647091 T4454 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 1647095 T4498 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1647095 T4454 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1647096 T4454 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1647097 T4454 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1647083 T4532 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1647097 T4498 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 1647099 T4454 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1647099 T4498 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1647103 T4482 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1647104 T4454 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 1647104 T4454 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 1647104 T4532
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1647105 T4532
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1647105 T4532 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1647107 T4454 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1930496316,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 1647108 T4454 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@6d7d7cfb
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1de117f6),segFN=segments_1,generation=1}
[junit4] 2> 1647108 T4454 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 1647108 T4454 oass.SolrIndexSearcher.<init> Opening
Searcher@203dc73a[solrj_collection_shard2_replica2] main
[junit4] 2> 1647108 T4454 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 1647108 T4482
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1647109 T4482
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1647109 T4482 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1647109 T4532
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1647109 T4532
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1647110 T4532 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard1_replica2' using configuration from collection
solrj_collection
[junit4] 2> 1647110 T4532 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1647110 T4532 oasc.SolrCore.<init>
[solrj_collection_shard1_replica2] Opening new SolrCore at
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-006\solrj_collection_shard1_replica2\,
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-006\solrj_collection_shard1_replica2\data\
[junit4] 2> 1647111 T4532 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3dad7f88
[junit4] 2> 1647111 T4532 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-006\solrj_collection_shard1_replica2\data\
[junit4] 2> 1647111 T4482
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1647111 T4532 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-006\solrj_collection_shard1_replica2\data\index/
[junit4] 2> 1647111 T4532 oasc.SolrCore.initIndex WARN
[solrj_collection_shard1_replica2] Solr index directory
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-006\solrj_collection_shard1_replica2\data\index'
doesn't exist. Creating new index...
[junit4] 2> 1647112 T4532 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-006\solrj_collection_shard1_replica2\data\index
[junit4] 2> 1647112 T4532 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@5f7e28b2
[junit4] 2> 1647111 T4482
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1647113 T4482 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard1_replica1' using configuration from collection
solrj_collection
[junit4] 2> 1647113 T4482 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1647114 T4532 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@4aa47766
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7182a29b),segFN=segments_1,generation=1}
[junit4] 2> 1647114 T4482 oasc.SolrCore.<init>
[solrj_collection_shard1_replica1] Opening new SolrCore at
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-003\solrj_collection_shard1_replica1\,
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-003\solrj_collection_shard1_replica1\data\
[junit4] 2> 1647114 T4482 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3dad7f88
[junit4] 2> 1647115 T4482 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-003\solrj_collection_shard1_replica1\data\
[junit4] 2> 1647115 T4482 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-003\solrj_collection_shard1_replica1\data\index/
[junit4] 2> 1647115 T4532 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 1647115 T4454 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 1647116 T4454 oasr.ManagedResourceStorage.newStorageIO Setting
up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 1647115 T4482 oasc.SolrCore.initIndex WARN
[solrj_collection_shard1_replica1] Solr index directory
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-003\solrj_collection_shard1_replica1\data\index'
doesn't exist. Creating new index...
[junit4] 2> 1647117 T4482 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-95E8142F369C3425-001\tempDir-003\solrj_collection_shard1_replica1\data\index
[junit4] 2> 1647117 T4482 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@aa1b8ed
[junit4] 2> 1647118 T4454
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 1647118 T4454 oasr.RestManager.init Initializing RestManager
with initArgs: {}
[junit4] 2> 1647119 T4454 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1647119 T4482 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@35b7a7c4
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@31af44fa),segFN=segments_1,generation=1}
[junit4] 2> 1647120 T4482 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 1647120 T4454
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 1647120 T4454 oasr.ManagedResourceStorage.load Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1647122 T4532 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 1647123 T4482 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 1647123 T4532 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 1647123 T4454 oascc.SolrZkClient.makePath makePath:
/configs/conf1/_rest_managed.json
[junit4] 2> 1647123 T4482 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 1647123 T4482 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1647123 T4532 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1647124 T4532 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 1647125 T4532 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1647125 T4532 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1647124 T4482 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 1647126 T4482 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1647126 T4482 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1647126 T4482 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1647127 T4482 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 1647127 T4482 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, cre
[...truncated too long message...]
ardDirectoryReader.java:326)
[junit4] 2> at
org.apache.lucene.index.FilterDirectoryReader.getVersion(FilterDirectoryReader.java:119)
[junit4] 2> at
org.apache.lucene.index.FilterDirectoryReader.getVersion(FilterDirectoryReader.java:119)
[junit4] 2> at
org.apache.solr.search.SolrIndexSearcher.getStatistics(SolrIndexSearcher.java:2240)
[junit4] 2> at
org.apache.solr.core.JmxMonitoredMap$SolrDynamicMBean.getMBeanInfo(JmxMonitoredMap.java:257)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getClassName(DefaultMBeanServerInterceptor.java:1804)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.safeGetClassName(DefaultMBeanServerInterceptor.java:1595)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.objectInstancesFromFilteredNamedObjects(DefaultMBeanServerInterceptor.java:1556)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.queryMBeansImpl(DefaultMBeanServerInterceptor.java:513)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.queryNames(DefaultMBeanServerInterceptor.java:526)
[junit4] 2> at
com.sun.jmx.mbeanserver.JmxMBeanServer.queryNames(JmxMBeanServer.java:619)
[junit4] 2> at
org.apache.solr.core.JmxMonitoredMap.clear(JmxMonitoredMap.java:120)
[junit4] 2> at
org.apache.solr.core.SolrCore.close(SolrCore.java:1127)
[junit4] 2> at
org.apache.solr.core.CoreContainer.unload(CoreContainer.java:690)
[junit4] 2> at
org.apache.solr.handler.admin.CoreAdminHandler.handleUnloadAction(CoreAdminHandler.java:666)
[junit4] 2> at
org.apache.solr.handler.admin.CoreAdminHandler.handleRequestInternal(CoreAdminHandler.java:209)
[junit4] 2> at
org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:188)
[junit4] 2> at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:137)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.handleAdminRequest(SolrDispatchFilter.java:738)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:254)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:201)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1419)
[junit4] 2> at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:137)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1419)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:455)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:229)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137)
[junit4] 2> at
org.eclipse.jetty.server.handler.GzipHandler.handle(GzipHandler.java:301)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1077)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:384)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1009)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
[junit4] 2> at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
[junit4] 2> at
org.eclipse.jetty.server.Server.handle(Server.java:368)
[junit4] 2> at
org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:489)
[junit4] 2> at
org.eclipse.jetty.server.AbstractHttpConnection.content(AbstractHttpConnection.java:953)
[junit4] 2> at
org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.content(AbstractHttpConnection.java:1014)
[junit4] 2> at
org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:861)
[junit4] 2> at
org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:240)
[junit4] 2> at
org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:82)
[junit4] 2> at
org.eclipse.jetty.io.nio.SslConnection.handle(SslConnection.java:196)
[junit4] 2> at
org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:628)
[junit4] 2> at
org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:52)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_40-ea
(64-bit)/cpus=2,threads=117,free=184969848,total=454344704
[junit4] 2> NOTE: All tests run in this JVM: [OpenCloseCoreStressTest,
HdfsChaosMonkeySafeLeaderTest, DateFieldTest, TestStressUserVersions,
UniqFieldsUpdateProcessorFactoryTest, TestClassNameShortening,
DefaultValueUpdateProcessorTest, AliasIntegrationTest, TestSolrCoreProperties,
QueryResultKeyTest, TestWordDelimiterFilterFactory, BasicDistributedZk2Test,
TestIndexingPerformance, TestDefaultSearchFieldResource,
TestManagedSchemaFieldTypeResource, QueryEqualityTest,
DistributedSpellCheckComponentTest, TestDocSet, TestSortingResponseWriter,
RequiredFieldsTest, IndexSchemaRuntimeFieldTest, TestJmxMonitoredMap,
TestPerFieldSimilarity, TestPivotHelperCode, TestMissingGroups,
TestPostingsSolrHighlighter, TermVectorComponentDistributedTest,
LeaderElectionTest, TestLMDirichletSimilarityFactory, TestBlobHandler,
SolrTestCaseJ4Test, TestConfigSets, SimpleFacetsTest,
TestManagedStopFilterFactory, StatsComponentTest,
TestManagedSynonymFilterFactory, ScriptEngineTest,
LeaderFailoverAfterPartitionTest, TestDistribDocBasedVersion,
TestCollectionAPI, SuggesterTSTTest, DeleteReplicaTest, PolyFieldTest,
SpellCheckCollatorTest, BasicDistributedZkTest, DateMathParserTest,
TestDynamicFieldCollectionResource, TestSchemaManager,
DisMaxRequestHandlerTest, TestRestManager, HdfsDirectoryTest, CircularListTest,
TestFoldingMultitermQuery, BlockDirectoryTest, TestManagedSchemaFieldResource,
LukeRequestHandlerTest, DirectUpdateHandlerOptimizeTest,
HdfsUnloadDistributedZkTest, TestReloadAndDeleteDocs, TestSolrXmlPersistence,
TestDefaultSimilarityFactory, TestReRankQParserPlugin,
AddSchemaFieldsUpdateProcessorFactoryTest, TestValueSourceCache,
TestCopyFieldCollectionResource, AsyncMigrateRouteKeyTest,
CoreMergeIndexesAdminHandlerTest, OutputWriterTest, NumericFieldsTest,
AnalyticsMergeStrategyTest, TestSolrDeletionPolicy1, TestSimpleQParserPlugin,
ZkNodePropsTest, DistributedQueryElevationComponentTest, TestCollationField,
DistributedSuggestComponentTest, NotRequiredUniqueKeyTest,
DistributedQueueTest, TestConfig, DistributedQueryComponentCustomSortTest,
TestSolrQueryParser, DirectUpdateHandlerTest, TestMergePolicyConfig,
CopyFieldTest, TestFieldCollectionResource, ExitableDirectoryReaderTest,
TestStressVersions, TestFastWriter, TestCursorMarkWithoutUniqueKey,
ParsingFieldUpdateProcessorsTest, TestBulkSchemaConcurrent, UpdateParamsTest,
ResourceLoaderTest, RAMDirectoryFactoryTest, TestBadConfig, AtomicUpdatesTest,
SolrCmdDistributorTest, CursorPagingTest, JSONWriterTest, TestFastLRUCache,
TestRandomMergePolicy, TermVectorComponentTest, URLClassifyProcessorTest,
TermsComponentTest, TestIntervalFaceting, TestTrie, TestBinaryResponseWriter,
SliceStateTest, TestSolrDeletionPolicy2, TestReversedWildcardFilterFactory,
ShardSplitTest, CurrencyFieldOpenExchangeTest, SystemInfoHandlerTest,
RankQueryTest, TestSearchPerf, CollectionsAPIDistributedZkTest]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=CollectionsAPIDistributedZkTest -Dtests.seed=95E8142F369C3425
-Dtests.slow=true -Dtests.locale=en_IE -Dtests.timezone=AET
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.00s | CollectionsAPIDistributedZkTest (suite) <<<
[junit4] > Throwable #1: java.lang.Exception: Suite timeout exceeded (>=
7200000 msec).
[junit4] > at
__randomizedtesting.SeedInfo.seed([95E8142F369C3425]:0)
[junit4] Completed in 7441.75s, 1 test, 2 errors <<< FAILURES!
[...truncated 1008 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:529: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:477: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:61: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\extra-targets.xml:39:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build.xml:190: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\common-build.xml:508:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:1363:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:970:
There were test failures: 452 suites, 1852 tests, 1 suite-level error, 1
error, 1215 ignored (20 assumptions)
Total time: 211 minutes 8 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.8.0_40-ea-b09
-XX:-UseCompressedOops -XX:+UseSerialGC (asserts: true)
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
